builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1496334144.43 results: success (0) revision: cac2fd43de81d44b36396704220996b0c4a39f1a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.432974) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.433483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.433787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.540696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.540980) ========= 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-1496333385.113082-876753787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 09:22:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2017-06-01 09:22:24 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.346474 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.914445) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.914756) ========= 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-1496333385.113082-876753787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.963726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:24.964021) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cac2fd43de81d44b36396704220996b0c4a39f1a --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 cac2fd43de81d44b36396704220996b0c4a39f1a --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-1496333385.113082-876753787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 09:22:25,035 truncating revision to first 12 chars 2017-06-01 09:22:25,035 Setting DEBUG logging. 2017-06-01 09:22:25,035 attempt 1/10 2017-06-01 09:22:25,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cac2fd43de81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 09:22:25,350 unpacking tar archive at: mozilla-central-cac2fd43de81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695726 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:25.674547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:25.674813) ========= script_repo_revision: cac2fd43de81d44b36396704220996b0c4a39f1a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:25.675146) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:25.678438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 09:22:25.686677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-01 09:22:25.686950) ========= /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-1496333385.113082-876753787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:25 INFO - MultiFileLogger online at 20170601 09:22:25 in /builds/slave/test 09:22:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:22:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:25 INFO - {'append_to_log': False, 09:22:25 INFO - 'base_work_dir': '/builds/slave/test', 09:22:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:22:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:25 INFO - 'branch': 'Firefox-Non-PGO', 09:22:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:25 INFO - 'config_files': ('talos/linux_config.py',), 09:22:25 INFO - 'default_actions': ('clobber', 09:22:25 INFO - 'read-buildbot-config', 09:22:25 INFO - 'download-and-extract', 09:22:25 INFO - 'populate-webroot', 09:22:25 INFO - 'create-virtualenv', 09:22:25 INFO - 'install', 09:22:25 INFO - 'setup-mitmproxy', 09:22:25 INFO - 'run-tests'), 09:22:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:25 INFO - 'download_minidump_stackwalk': True, 09:22:25 INFO - 'download_symbols': 'ondemand', 09:22:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:25 INFO - 'gecko_profile': False, 09:22:25 INFO - 'gecko_profile_interval': 0, 09:22:25 INFO - 'installer_path': 'installer.exe', 09:22:25 INFO - 'log_level': 'info', 09:22:25 INFO - 'log_name': 'talos', 09:22:25 INFO - 'log_to_console': True, 09:22:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:25 INFO - 'opt_config_files': (), 09:22:25 INFO - 'pip_index': False, 09:22:25 INFO - 'suite': 'dromaeojs-e10s', 09:22:25 INFO - 'system_bits': '32', 09:22:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:25 INFO - 'title': 'talos-linux64-ix-013', 09:22:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:25 INFO - 'use_talos_json': True, 09:22:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:25 INFO - 'work_dir': 'build'} 09:22:25 INFO - [mozharness: 2017-06-01 16:22:25.854570Z] Running clobber step. 09:22:25 INFO - Running pre-action listener: _resource_record_pre_action 09:22:25 INFO - Running main action method: clobber 09:22:25 INFO - rmtree: /builds/slave/test/build 09:22:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:26 INFO - Running post-action listener: _resource_record_post_action 09:22:26 INFO - [mozharness: 2017-06-01 16:22:26.886003Z] Finished clobber step (success) 09:22:26 INFO - [mozharness: 2017-06-01 16:22:26.886105Z] Running read-buildbot-config step. 09:22:26 INFO - Running pre-action listener: _resource_record_pre_action 09:22:26 INFO - Running main action method: read_buildbot_config 09:22:26 INFO - Using buildbot properties: 09:22:26 INFO - { 09:22:26 INFO - "project": "", 09:22:26 INFO - "product": "firefox", 09:22:26 INFO - "who": "ryanvm@gmail.com", 09:22:26 INFO - "installer_path": "public/build/target.tar.bz2", 09:22:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:22:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:22:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:22:26 INFO - "stage_platform": "linux64", 09:22:26 INFO - "basedir": "/builds/slave/test", 09:22:26 INFO - "buildnumber": 878, 09:22:26 INFO - "platform": "ubuntu64_hw", 09:22:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:22:26 INFO - "slavebuilddir": "test", 09:22:26 INFO - "taskId": "cakcQYEJROKCuZPee0xn9Q", 09:22:26 INFO - "branch": "mozilla-central", 09:22:26 INFO - "script_repo_revision": "production", 09:22:26 INFO - "revision": "cac2fd43de81d44b36396704220996b0c4a39f1a", 09:22:26 INFO - "slavename": "talos-linux64-ix-013", 09:22:26 INFO - "repo_path": "mozilla-central" 09:22:26 INFO - } 09:22:26 INFO - Finding installer, test and symbols from parent task. 09:22:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cakcQYEJROKCuZPee0xn9Q'}, attempt #1 09:22:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cakcQYEJROKCuZPee0xn9Q'}, attempt #1 09:22:27 INFO - Task dependencies: VqFKKkZ5Qv2qKizPxPAhSw 09:22:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw'}, attempt #1 09:22:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2 09:22:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/test_packages.json 09:22:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.crashreporter-symbols.zip 09:22:28 INFO - Running post-action listener: _resource_record_post_action 09:22:28 INFO - [mozharness: 2017-06-01 16:22:28.310337Z] Finished read-buildbot-config step (success) 09:22:28 INFO - [mozharness: 2017-06-01 16:22:28.310560Z] Running download-and-extract step. 09:22:28 INFO - Running pre-action listener: _resource_record_pre_action 09:22:28 INFO - Running main action method: download_and_extract 09:22:28 INFO - mkdir: /builds/slave/test/build/tests 09:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:28 INFO - trying https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.test_packages.json 09:22:28 INFO - Downloading https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:22:28 INFO - Downloaded 986 bytes. 09:22:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:22:28 INFO - Using the following test package requirements: 09:22:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:22:28 INFO - u'common': [u'target.common.tests.zip'], 09:22:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:22:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:22:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:22:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:22:28 INFO - u'mozbase': [u'target.common.tests.zip'], 09:22:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:22:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:22:28 INFO - u'web-platform': [u'target.common.tests.zip', 09:22:28 INFO - u'target.web-platform.tests.zip'], 09:22:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:22:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:22:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.common.tests.zip 09:22:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:22:28 INFO - Fetch https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.common.tests.zip into memory 09:22:31 INFO - Content-Length response header: 63535403 09:22:31 INFO - Bytes received: 63535403 09:22:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:22:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.common.tests.zip 09:22:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:22:42 INFO - Fetch https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.common.tests.zip into memory 09:22:44 INFO - Content-Length response header: 63535403 09:22:44 INFO - Bytes received: 63535403 09:22:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.talos.tests.zip 09:22:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:22:56 INFO - Fetch https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.talos.tests.zip into memory 09:22:57 INFO - Content-Length response header: 14447425 09:22:57 INFO - Bytes received: 14447425 09:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:57 INFO - trying https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2 09:22:57 INFO - Downloading https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:22:59 INFO - Downloaded 54137842 bytes. 09:22:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2 09:22:59 INFO - mkdir: /builds/slave/test/properties 09:22:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:22:59 INFO - Writing to file /builds/slave/test/properties/build_url 09:22:59 INFO - Contents: 09:22:59 INFO - build_url:https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2 09:22:59 INFO - Running post-action listener: _resource_record_post_action 09:22:59 INFO - Running post-action listener: set_extra_try_arguments 09:22:59 INFO - [mozharness: 2017-06-01 16:22:59.930203Z] Finished download-and-extract step (success) 09:22:59 INFO - [mozharness: 2017-06-01 16:22:59.930356Z] Running populate-webroot step. 09:22:59 INFO - Running pre-action listener: _resource_record_pre_action 09:22:59 INFO - Running main action method: populate_webroot 09:22:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:22:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:22:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:22:59 INFO - '--tppagecycles', 09:22:59 INFO - '7'], 09:22:59 INFO - 'tests': ['tsvgm']}}, 09:22:59 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:22:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:22:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:22:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:22:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['damp', 'tps']}, 09:22:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'tests': ['damp', 'tps']}, 09:22:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['dromaeo_dom']}, 09:22:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:22:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:22:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:22:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:22:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['a11yr', 09:22:59 INFO - 'ts_paint', 09:22:59 INFO - 'tpaint', 09:22:59 INFO - 'sessionrestore', 09:22:59 INFO - 'sessionrestore_no_auto_restore', 09:22:59 INFO - 'tabpaint']}, 09:22:59 INFO - 'other-e10s': {'tests': ['a11yr', 09:22:59 INFO - 'ts_paint', 09:22:59 INFO - 'tpaint', 09:22:59 INFO - 'sessionrestore', 09:22:59 INFO - 'sessionrestore_no_auto_restore', 09:22:59 INFO - 'tabpaint']}, 09:22:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:22:59 INFO - 'ts_paint', 09:22:59 INFO - 'tpaint', 09:22:59 INFO - 'sessionrestore', 09:22:59 INFO - 'sessionrestore_no_auto_restore', 09:22:59 INFO - 'tabpaint']}, 09:22:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:22:59 INFO - 'ts_paint', 09:22:59 INFO - 'tpaint', 09:22:59 INFO - 'sessionrestore', 09:22:59 INFO - 'sessionrestore_no_auto_restore', 09:22:59 INFO - 'tabpaint']}, 09:22:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['a11yr', 09:22:59 INFO - 'ts_paint', 09:22:59 INFO - 'tpaint', 09:22:59 INFO - 'sessionrestore', 09:22:59 INFO - 'sessionrestore_no_auto_restore', 09:22:59 INFO - 'tabpaint']}, 09:22:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['a11yr', 09:22:59 INFO - 'ts_paint', 09:22:59 INFO - 'tpaint', 09:22:59 INFO - 'sessionrestore', 09:22:59 INFO - 'sessionrestore_no_auto_restore', 09:22:59 INFO - 'tabpaint']}, 09:22:59 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:22:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:22:59 INFO - 'bloom_basic_ref']}, 09:22:59 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:22:59 INFO - 'talos_options': ['--mitmproxy', 09:22:59 INFO - 'mitmproxy-recording-1.mp', 09:22:59 INFO - '--firstNonBlankPaint'], 09:22:59 INFO - 'tests': ['Quantum_1']}, 09:22:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['tsvgx', 09:22:59 INFO - 'tsvgr_opacity', 09:22:59 INFO - 'tart', 09:22:59 INFO - 'tscrollx', 09:22:59 INFO - 'cart', 09:22:59 INFO - 'tsvg_static']}, 09:22:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:22:59 INFO - 'tsvgr_opacity', 09:22:59 INFO - 'tart', 09:22:59 INFO - 'tscrollx', 09:22:59 INFO - 'cart', 09:22:59 INFO - 'tsvg_static']}, 09:22:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'talos_options': ['--disable-e10s'], 09:22:59 INFO - 'tests': ['tp5o']}, 09:22:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:22:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'talos_options': ['--disable-e10s', 09:22:59 INFO - '--xperf_path', 09:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:59 INFO - 'tests': ['tp5n']}, 09:22:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:22:59 INFO - 'talos_options': ['--xperf_path', 09:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:22:59 INFO - 'tests': ['tp5n']}}, 09:22:59 INFO - 'talos.zip': {'path': '', 09:22:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:22:59 INFO - Running post-action listener: _resource_record_post_action 09:22:59 INFO - [mozharness: 2017-06-01 16:22:59.946028Z] Finished populate-webroot step (success) 09:22:59 INFO - [mozharness: 2017-06-01 16:22:59.946124Z] Running create-virtualenv step. 09:22:59 INFO - Running pre-action listener: _resource_record_pre_action 09:22:59 INFO - Running main action method: create_virtualenv 09:22:59 INFO - Creating virtualenv /builds/slave/test/build/venv 09:22:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:22:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:22:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:23:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:00 INFO - Using real prefix '/usr' 09:23:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:00 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:02 INFO - Installing pip.................done. 09:23:02 INFO - Return code: 0 09:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:02 INFO - Reading from file tmpfile_stdout 09:23:02 INFO - Output received: 09:23:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:23:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:02 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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:02 INFO - Using env: {'DISPLAY': ':0', 09:23:02 INFO - 'HOME': '/home/cltbld', 09:23:02 INFO - 'LANG': 'en_US.UTF-8', 09:23:02 INFO - 'LANGUAGE': 'en_US:en', 09:23:02 INFO - 'LOGNAME': 'cltbld', 09:23:02 INFO - 'MAIL': '/var/mail/cltbld', 09:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:02 INFO - 'MOZ_NO_REMOTE': '1', 09:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:02 INFO - 'NO_EM_RESTART': '1', 09:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:02 INFO - 'PWD': '/builds/slave/test', 09:23:02 INFO - 'SHELL': '/bin/bash', 09:23:02 INFO - 'SHLVL': '1', 09:23:02 INFO - 'TERM': 'linux', 09:23:02 INFO - 'TMOUT': '86400', 09:23:02 INFO - 'USER': 'cltbld', 09:23:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:02 INFO - '_': '/tools/buildbot/bin/python'} 09:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:23:02 INFO - Cleaning up... 09:23:02 INFO - Return code: 0 09:23:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:02 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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:23:02 INFO - Using env: {'DISPLAY': ':0', 09:23:02 INFO - 'HOME': '/home/cltbld', 09:23:02 INFO - 'LANG': 'en_US.UTF-8', 09:23:02 INFO - 'LANGUAGE': 'en_US:en', 09:23:02 INFO - 'LOGNAME': 'cltbld', 09:23:02 INFO - 'MAIL': '/var/mail/cltbld', 09:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:02 INFO - 'MOZ_NO_REMOTE': '1', 09:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:02 INFO - 'NO_EM_RESTART': '1', 09:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:02 INFO - 'PWD': '/builds/slave/test', 09:23:02 INFO - 'SHELL': '/bin/bash', 09:23:02 INFO - 'SHLVL': '1', 09:23:02 INFO - 'TERM': 'linux', 09:23:02 INFO - 'TMOUT': '86400', 09:23:02 INFO - 'USER': 'cltbld', 09:23:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:02 INFO - '_': '/tools/buildbot/bin/python'} 09:23:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:03 INFO - Downloading/unpacking psutil>=3.1.1 09:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:04 INFO - Installing collected packages: psutil 09:23:04 INFO - Running setup.py install for psutil 09:23:04 INFO - building 'psutil._psutil_linux' extension 09:23:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:23:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:23:04 INFO - building 'psutil._psutil_posix' extension 09:23:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:23:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:23:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:05 INFO - Successfully installed psutil 09:23:05 INFO - Cleaning up... 09:23:05 INFO - Return code: 0 09:23:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:23:05 INFO - Using env: {'DISPLAY': ':0', 09:23:05 INFO - 'HOME': '/home/cltbld', 09:23:05 INFO - 'LANG': 'en_US.UTF-8', 09:23:05 INFO - 'LANGUAGE': 'en_US:en', 09:23:05 INFO - 'LOGNAME': 'cltbld', 09:23:05 INFO - 'MAIL': '/var/mail/cltbld', 09:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:05 INFO - 'MOZ_NO_REMOTE': '1', 09:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:05 INFO - 'NO_EM_RESTART': '1', 09:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:05 INFO - 'PWD': '/builds/slave/test', 09:23:05 INFO - 'SHELL': '/bin/bash', 09:23:05 INFO - 'SHLVL': '1', 09:23:05 INFO - 'TERM': 'linux', 09:23:05 INFO - 'TMOUT': '86400', 09:23:05 INFO - 'USER': 'cltbld', 09:23:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:05 INFO - '_': '/tools/buildbot/bin/python'} 09:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:06 INFO - Installing collected packages: mozsystemmonitor 09:23:06 INFO - Running setup.py install for mozsystemmonitor 09:23:06 INFO - Successfully installed mozsystemmonitor 09:23:06 INFO - Cleaning up... 09:23:06 INFO - Return code: 0 09:23:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:06 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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:23:06 INFO - Using env: {'DISPLAY': ':0', 09:23:06 INFO - 'HOME': '/home/cltbld', 09:23:06 INFO - 'LANG': 'en_US.UTF-8', 09:23:06 INFO - 'LANGUAGE': 'en_US:en', 09:23:06 INFO - 'LOGNAME': 'cltbld', 09:23:06 INFO - 'MAIL': '/var/mail/cltbld', 09:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:06 INFO - 'MOZ_NO_REMOTE': '1', 09:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:06 INFO - 'NO_EM_RESTART': '1', 09:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:06 INFO - 'PWD': '/builds/slave/test', 09:23:06 INFO - 'SHELL': '/bin/bash', 09:23:06 INFO - 'SHLVL': '1', 09:23:06 INFO - 'TERM': 'linux', 09:23:06 INFO - 'TMOUT': '86400', 09:23:06 INFO - 'USER': 'cltbld', 09:23:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:06 INFO - '_': '/tools/buildbot/bin/python'} 09:23:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:08 INFO - warning: no files found matching '*.txt' 09:23:08 INFO - no previously-included directories found matching 'build' 09:23:08 INFO - no previously-included directories found matching 'dist' 09:23:08 INFO - no previously-included directories found matching '.git*' 09:23:08 INFO - Installing collected packages: jsonschema, functools32 09:23:08 INFO - Running setup.py install for functools32 09:23:08 INFO - warning: no files found matching '*.txt' 09:23:08 INFO - no previously-included directories found matching 'build' 09:23:08 INFO - no previously-included directories found matching 'dist' 09:23:08 INFO - no previously-included directories found matching '.git*' 09:23:08 INFO - Successfully installed jsonschema functools32 09:23:08 INFO - Cleaning up... 09:23:08 INFO - Return code: 0 09:23:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:23:08 INFO - Using env: {'DISPLAY': ':0', 09:23:08 INFO - 'HOME': '/home/cltbld', 09:23:08 INFO - 'LANG': 'en_US.UTF-8', 09:23:08 INFO - 'LANGUAGE': 'en_US:en', 09:23:08 INFO - 'LOGNAME': 'cltbld', 09:23:08 INFO - 'MAIL': '/var/mail/cltbld', 09:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:08 INFO - 'MOZ_NO_REMOTE': '1', 09:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:08 INFO - 'NO_EM_RESTART': '1', 09:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:08 INFO - 'PWD': '/builds/slave/test', 09:23:08 INFO - 'SHELL': '/bin/bash', 09:23:08 INFO - 'SHLVL': '1', 09:23:08 INFO - 'TERM': 'linux', 09:23:08 INFO - 'TMOUT': '86400', 09:23:08 INFO - 'USER': 'cltbld', 09:23:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:08 INFO - '_': '/tools/buildbot/bin/python'} 09:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:08 INFO - Cleaning up... 09:23:08 INFO - Return code: 0 09:23:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:23:08 INFO - Using env: {'DISPLAY': ':0', 09:23:08 INFO - 'HOME': '/home/cltbld', 09:23:08 INFO - 'LANG': 'en_US.UTF-8', 09:23:08 INFO - 'LANGUAGE': 'en_US:en', 09:23:08 INFO - 'LOGNAME': 'cltbld', 09:23:08 INFO - 'MAIL': '/var/mail/cltbld', 09:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:08 INFO - 'MOZ_NO_REMOTE': '1', 09:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:08 INFO - 'NO_EM_RESTART': '1', 09:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:08 INFO - 'PWD': '/builds/slave/test', 09:23:08 INFO - 'SHELL': '/bin/bash', 09:23:08 INFO - 'SHLVL': '1', 09:23:08 INFO - 'TERM': 'linux', 09:23:08 INFO - 'TMOUT': '86400', 09:23:08 INFO - 'USER': 'cltbld', 09:23:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:08 INFO - '_': '/tools/buildbot/bin/python'} 09:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:08 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:09 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:10 INFO - Downloading docopt-0.6.1.tar.gz 09:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:10 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:10 INFO - Running setup.py install for blobuploader 09:23:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:10 INFO - Running setup.py install for requests 09:23:10 INFO - Running setup.py install for docopt 09:23:10 INFO - Successfully installed blobuploader requests docopt 09:23:10 INFO - Cleaning up... 09:23:10 INFO - Return code: 0 09:23:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:10 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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:23:10 INFO - Using env: {'DISPLAY': ':0', 09:23:10 INFO - 'HOME': '/home/cltbld', 09:23:10 INFO - 'LANG': 'en_US.UTF-8', 09:23:10 INFO - 'LANGUAGE': 'en_US:en', 09:23:10 INFO - 'LOGNAME': 'cltbld', 09:23:10 INFO - 'MAIL': '/var/mail/cltbld', 09:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:10 INFO - 'MOZ_NO_REMOTE': '1', 09:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:10 INFO - 'NO_EM_RESTART': '1', 09:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:10 INFO - 'PWD': '/builds/slave/test', 09:23:10 INFO - 'SHELL': '/bin/bash', 09:23:10 INFO - 'SHLVL': '1', 09:23:10 INFO - 'TERM': 'linux', 09:23:10 INFO - 'TMOUT': '86400', 09:23:10 INFO - 'USER': 'cltbld', 09:23:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:10 INFO - '_': '/tools/buildbot/bin/python'} 09:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:11 INFO - Running setup.py (path:/tmp/pip-BpgGvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:11 INFO - Running setup.py (path:/tmp/pip-rPxtCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:11 INFO - Running setup.py (path:/tmp/pip-oo6C5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:11 INFO - Running setup.py (path:/tmp/pip-a0qbkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:11 INFO - Running setup.py (path:/tmp/pip-Z0cPel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:11 INFO - Running setup.py (path:/tmp/pip-2TQnp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:11 INFO - Running setup.py (path:/tmp/pip-JVYYEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:11 INFO - Running setup.py (path:/tmp/pip-p_qWoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:11 INFO - Running setup.py (path:/tmp/pip-JNfXsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:11 INFO - Running setup.py (path:/tmp/pip-gTLUcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:11 INFO - Running setup.py (path:/tmp/pip-yEpQMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:11 INFO - Running setup.py (path:/tmp/pip-AkXTuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:12 INFO - Running setup.py (path:/tmp/pip-BUpgjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:12 INFO - Running setup.py (path:/tmp/pip-jI_MuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:12 INFO - Running setup.py (path:/tmp/pip-PDFT2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:12 INFO - Running setup.py (path:/tmp/pip-2U4ri6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:12 INFO - Running setup.py (path:/tmp/pip-cyU3oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:12 INFO - Running setup.py install for manifestparser 09:23:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:12 INFO - Running setup.py install for mozcrash 09:23:12 INFO - Running setup.py install for mozdebug 09:23:12 INFO - Running setup.py install for mozdevice 09:23:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:12 INFO - Running setup.py install for mozfile 09:23:12 INFO - Running setup.py install for mozhttpd 09:23:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:12 INFO - Running setup.py install for mozinfo 09:23:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Running setup.py install for mozInstall 09:23:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Running setup.py install for mozleak 09:23:13 INFO - Running setup.py install for mozlog 09:23:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Running setup.py install for moznetwork 09:23:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Running setup.py install for mozprocess 09:23:13 INFO - Running setup.py install for mozprofile 09:23:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Running setup.py install for mozrunner 09:23:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:13 INFO - Running setup.py install for mozscreenshot 09:23:13 INFO - Running setup.py install for moztest 09:23:14 INFO - Running setup.py install for mozversion 09:23:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:14 INFO - Cleaning up... 09:23:14 INFO - Return code: 0 09:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:14 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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:23:14 INFO - Using env: {'DISPLAY': ':0', 09:23:14 INFO - 'HOME': '/home/cltbld', 09:23:14 INFO - 'LANG': 'en_US.UTF-8', 09:23:14 INFO - 'LANGUAGE': 'en_US:en', 09:23:14 INFO - 'LOGNAME': 'cltbld', 09:23:14 INFO - 'MAIL': '/var/mail/cltbld', 09:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:14 INFO - 'MOZ_NO_REMOTE': '1', 09:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:14 INFO - 'NO_EM_RESTART': '1', 09:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:14 INFO - 'PWD': '/builds/slave/test', 09:23:14 INFO - 'SHELL': '/bin/bash', 09:23:14 INFO - 'SHLVL': '1', 09:23:14 INFO - 'TERM': 'linux', 09:23:14 INFO - 'TMOUT': '86400', 09:23:14 INFO - 'USER': 'cltbld', 09:23:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:14 INFO - '_': '/tools/buildbot/bin/python'} 09:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:14 INFO - Running setup.py (path:/tmp/pip-fJrVNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:14 INFO - Running setup.py (path:/tmp/pip-3gMAZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:14 INFO - Running setup.py (path:/tmp/pip-C8zkmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:14 INFO - Running setup.py (path:/tmp/pip-Wudt_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:14 INFO - Running setup.py (path:/tmp/pip-SMH1Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:14 INFO - Running setup.py (path:/tmp/pip-FUxqYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:14 INFO - Running setup.py (path:/tmp/pip-H3LOzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:14 INFO - Running setup.py (path:/tmp/pip-P5RMzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:14 INFO - Running setup.py (path:/tmp/pip-1EM42G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:15 INFO - Running setup.py (path:/tmp/pip-ZJIgnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:15 INFO - Running setup.py (path:/tmp/pip-87Fv_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:15 INFO - Running setup.py (path:/tmp/pip-Dwws7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:15 INFO - Running setup.py (path:/tmp/pip-E42WGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:15 INFO - Running setup.py (path:/tmp/pip-_P632e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:15 INFO - Running setup.py (path:/tmp/pip-fP4hVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:15 INFO - Running setup.py (path:/tmp/pip-xJQhvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:15 INFO - Running setup.py (path:/tmp/pip-ViKvtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:23:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:16 INFO - Downloading blessings-1.6.tar.gz 09:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:16 INFO - Installing collected packages: blessings 09:23:16 INFO - Running setup.py install for blessings 09:23:16 INFO - Successfully installed blessings 09:23:16 INFO - Cleaning up... 09:23:16 INFO - Return code: 0 09:23:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:17 INFO - Reading from file tmpfile_stdout 09:23:17 INFO - Current package versions: 09:23:17 INFO - argparse == 1.2.1 09:23:17 INFO - blessings == 1.6 09:23:17 INFO - blobuploader == 1.2.4 09:23:17 INFO - docopt == 0.6.1 09:23:17 INFO - functools32 == 3.2.3-2 09:23:17 INFO - jsonschema == 2.5.1 09:23:17 INFO - manifestparser == 1.1 09:23:17 INFO - mozInstall == 1.12 09:23:17 INFO - mozcrash == 1.0 09:23:17 INFO - mozdebug == 0.1 09:23:17 INFO - mozdevice == 0.51 09:23:17 INFO - mozfile == 1.2 09:23:17 INFO - mozhttpd == 0.7 09:23:17 INFO - mozinfo == 0.9 09:23:17 INFO - mozleak == 0.1 09:23:17 INFO - mozlog == 3.4 09:23:17 INFO - moznetwork == 0.27 09:23:17 INFO - mozprocess == 0.25 09:23:17 INFO - mozprofile == 0.28 09:23:17 INFO - mozrunner == 6.13 09:23:17 INFO - mozscreenshot == 0.1 09:23:17 INFO - mozsystemmonitor == 0.3 09:23:17 INFO - moztest == 0.8 09:23:17 INFO - mozversion == 1.4 09:23:17 INFO - psutil == 3.1.1 09:23:17 INFO - requests == 1.2.3 09:23:17 INFO - wsgiref == 0.1.2 09:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:17 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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:23:17 INFO - Using env: {'DISPLAY': ':0', 09:23:17 INFO - 'HOME': '/home/cltbld', 09:23:17 INFO - 'LANG': 'en_US.UTF-8', 09:23:17 INFO - 'LANGUAGE': 'en_US:en', 09:23:17 INFO - 'LOGNAME': 'cltbld', 09:23:17 INFO - 'MAIL': '/var/mail/cltbld', 09:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:17 INFO - 'MOZ_NO_REMOTE': '1', 09:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:17 INFO - 'NO_EM_RESTART': '1', 09:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:17 INFO - 'PWD': '/builds/slave/test', 09:23:17 INFO - 'SHELL': '/bin/bash', 09:23:17 INFO - 'SHLVL': '1', 09:23:17 INFO - 'TERM': 'linux', 09:23:17 INFO - 'TMOUT': '86400', 09:23:17 INFO - 'USER': 'cltbld', 09:23:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:17 INFO - '_': '/tools/buildbot/bin/python'} 09:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:23:17 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:18 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:23:18 INFO - Installing collected packages: marionette-driver 09:23:18 INFO - Running setup.py install for marionette-driver 09:23:18 INFO - Successfully installed marionette-driver 09:23:18 INFO - Cleaning up... 09:23:18 INFO - Return code: 0 09:23:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:18 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 0x297d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b57a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cfbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, '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-1496333385.113082-876753787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:23:18 INFO - Using env: {'DISPLAY': ':0', 09:23:18 INFO - 'HOME': '/home/cltbld', 09:23:18 INFO - 'LANG': 'en_US.UTF-8', 09:23:18 INFO - 'LANGUAGE': 'en_US:en', 09:23:18 INFO - 'LOGNAME': 'cltbld', 09:23:18 INFO - 'MAIL': '/var/mail/cltbld', 09:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:18 INFO - 'MOZ_NO_REMOTE': '1', 09:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:18 INFO - 'NO_EM_RESTART': '1', 09:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:18 INFO - 'PWD': '/builds/slave/test', 09:23:18 INFO - 'SHELL': '/bin/bash', 09:23:18 INFO - 'SHLVL': '1', 09:23:18 INFO - 'TERM': 'linux', 09:23:18 INFO - 'TMOUT': '86400', 09:23:18 INFO - 'USER': 'cltbld', 09:23:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:18 INFO - '_': '/tools/buildbot/bin/python'} 09:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:18 INFO - Cleaning up... 09:23:18 INFO - Return code: 0 09:23:18 INFO - Running post-action listener: _resource_record_post_action 09:23:18 INFO - Running post-action listener: _start_resource_monitoring 09:23:18 INFO - Starting resource monitoring. 09:23:18 INFO - [mozharness: 2017-06-01 16:23:18.944799Z] Finished create-virtualenv step (success) 09:23:18 INFO - [mozharness: 2017-06-01 16:23:18.945273Z] Running install step. 09:23:18 INFO - Running pre-action listener: _resource_record_pre_action 09:23:18 INFO - Running main action method: install 09:23:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:19 INFO - Reading from file tmpfile_stdout 09:23:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:19 INFO - Reading from file tmpfile_stdout 09:23:19 INFO - Output received: 09:23:19 INFO - Usage: mozinstall [options] installer 09:23:19 INFO - Options: 09:23:19 INFO - -h, --help show this help message and exit 09:23:19 INFO - -d DEST, --destination=DEST 09:23:19 INFO - Directory to install application into. [default: 09:23:19 INFO - "/builds/slave/test"] 09:23:19 INFO - --app=APP Application being installed. [default: firefox] 09:23:19 INFO - mkdir: /builds/slave/test/build/application 09:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:23:34 INFO - Reading from file tmpfile_stdout 09:23:34 INFO - Output received: 09:23:34 INFO - /builds/slave/test/build/application/firefox/firefox 09:23:34 INFO - Running post-action listener: _resource_record_post_action 09:23:34 INFO - [mozharness: 2017-06-01 16:23:34.878868Z] Finished install step (success) 09:23:34 INFO - [mozharness: 2017-06-01 16:23:34.879016Z] Running setup-mitmproxy step. 09:23:34 INFO - Running pre-action listener: _resource_record_pre_action 09:23:34 INFO - Running main action method: setup_mitmproxy 09:23:34 INFO - Skipping: mitmproxy is not required 09:23:34 INFO - Running post-action listener: _resource_record_post_action 09:23:34 INFO - [mozharness: 2017-06-01 16:23:34.879554Z] Finished setup-mitmproxy step (success) 09:23:34 INFO - [mozharness: 2017-06-01 16:23:34.879685Z] Running run-tests step. 09:23:34 INFO - Running pre-action listener: _resource_record_pre_action 09:23:34 INFO - Running main action method: run_tests 09:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:23:34 INFO - Python 2.7.3 09:23:34 INFO - Return code: 0 09:23:34 INFO - grabbing minidump binary from tooltool 09:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:34 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 0x2cf8840>, '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 0x2cf9740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf9bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:23:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:23:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:23:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:23:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:34 INFO - Return code: 0 09:23:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:23:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:23:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:23:34 INFO - ENV: RUST_BACKTRACE is now 1 09:23:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:23:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:23:34 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/VqFKKkZ5Qv2qKizPxPAhSw/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 09:23:34 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/VqFKKkZ5Qv2qKizPxPAhSw/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 09:23:34 INFO - Using env: {'DISPLAY': ':0', 09:23:34 INFO - 'HOME': '/home/cltbld', 09:23:34 INFO - 'LANG': 'en_US.UTF-8', 09:23:34 INFO - 'LANGUAGE': 'en_US:en', 09:23:34 INFO - 'LOGNAME': 'cltbld', 09:23:34 INFO - 'MAIL': '/var/mail/cltbld', 09:23:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:23:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:34 INFO - 'MOZ_NO_REMOTE': '1', 09:23:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:34 INFO - 'NO_EM_RESTART': '1', 09:23:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:34 INFO - 'PWD': '/builds/slave/test', 09:23:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:23:34 INFO - 'RUST_BACKTRACE': '1', 09:23:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:23:34 INFO - 'SHELL': '/bin/bash', 09:23:34 INFO - 'SHLVL': '1', 09:23:34 INFO - 'TERM': 'linux', 09:23:34 INFO - 'TMOUT': '86400', 09:23:34 INFO - 'USER': 'cltbld', 09:23:34 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1496333385.113082-876753787', 09:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:34 INFO - '_': '/tools/buildbot/bin/python'} 09:23:34 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/VqFKKkZ5Qv2qKizPxPAhSw/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 09:23:35 INFO - mozversion application_buildid: 20170601155415 09:23:35 INFO - mozversion application_changeset: cac2fd43de81d44b36396704220996b0c4a39f1a 09:23:35 INFO - mozversion application_display_name: Nightly 09:23:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:35 INFO - mozversion application_name: Firefox 09:23:35 INFO - mozversion application_remotingname: firefox 09:23:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:23:35 INFO - mozversion application_vendor: Mozilla 09:23:35 INFO - mozversion application_version: 55.0a1 09:23:35 INFO - mozversion platform_buildid: 20170601155415 09:23:35 INFO - mozversion platform_changeset: cac2fd43de81d44b36396704220996b0c4a39f1a 09:23:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:23:35 INFO - mozversion platform_version: 55.0a1 09:23:35 INFO - using testdate: 1496334215 09:23:35 INFO - actual date: 1496334215 09:23:35 INFO - starting webserver on 'localhost:47784' 09:23:35 INFO - SUITE-START | Running 2 tests 09:23:35 INFO - TEST-START | dromaeo_css 09:23:35 INFO - operating with platform_type : linux_ 09:23:35 INFO - Initialising browser for dromaeo_css test... 09:23:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47784/getInfo.html -profile /tmp/tmp_9WzwV/profile 09:23:35 INFO - TEST-INFO | started process 32545 (/builds/slave/test/build/application/firefox/firefox http://localhost:47784/getInfo.html) 09:24:10 INFO - TEST-INFO | 32545: killed by SIGTERM 09:24:10 INFO - Browser initialized. 09:24:10 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:10 INFO - TEST-INFO | started process 32747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_9WzwV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:22 INFO - PID 32747 | RSS: Main: 184373248 09:24:22 INFO - PID 32747 | 09:27:26 INFO - PID 32747 | Cycle 1(1): loaded http://localhost:47784/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47784/tests/dromaeo/cssquery-ext.html) 09:27:28 INFO - PID 32747 | RSS: Main: 180482048 09:27:28 INFO - PID 32747 | 09:30:30 INFO - PID 32747 | Cycle 1(1): loaded http://localhost:47784/tests/dromaeo/cssquery-ext.html (next: http://localhost:47784/tests/dromaeo/cssquery-jquery.html) 09:30:30 INFO - PID 32747 | RSS: Main: 184516608 09:30:30 INFO - PID 32747 | 09:33:32 INFO - PID 32747 | Cycle 1(1): loaded http://localhost:47784/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47784/tests/dromaeo/cssquery-mootools.html) 09:33:33 INFO - PID 32747 | RSS: Main: 182837248 09:33:33 INFO - PID 32747 | 09:36:34 INFO - PID 32747 | Cycle 1(1): loaded http://localhost:47784/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47784/tests/dromaeo/cssquery-prototype.html) 09:36:35 INFO - PID 32747 | RSS: Main: 187183104 09:36:35 INFO - PID 32747 | 09:39:38 INFO - PID 32747 | Cycle 1(1): loaded http://localhost:47784/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47784/tests/dromaeo/cssquery-yui.html) 09:39:39 INFO - PID 32747 | RSS: Main: 185454592 09:39:39 INFO - PID 32747 | 09:42:40 INFO - PID 32747 | Cycle 1(1): loaded http://localhost:47784/tests/dromaeo/cssquery-yui.html (next: http://localhost:47784/tests/dromaeo/cssquery-dojo.html) 09:42:41 INFO - PID 32747 | RSS: Main: 182820864 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | __start_tp_report 09:42:41 INFO - PID 32747 | _x_x_mozilla_page_load 09:42:41 INFO - PID 32747 | _x_x_mozilla_page_load_details 09:42:41 INFO - PID 32747 | |i|pagename|runs| 09:42:41 INFO - PID 32747 | |0;dojo.html;2694.232143839006;2718.4427192425555;2725.918222453326;2738.1101142128814;2751.614773931649;5170.991656626959;5224.686518808874;5241.947580524194;5265.236540701596;5271.525562699357;5146.45962173971;5192.844214673556;5253.159494480874;5283.471652834714;5292.920606190901;4441.947848416755;4621.907561848761;4627.3521706961055;4670.042641258534;4674.368960190382;4675.88310292242;4694.600958918479;4710.74090924999;4717.716936983792;4720.3391525186325;4512.323151527265;4620.214563524209;4623.537646235383;4646.233371493699;4684.508126646687;4672.462666793328;4674.719516829001;4678.6491013174145;4703.717776933361;4727.57451829337;4589.311603259504;4639.76801159944;4643.094596553673;4661.3241080043545;4680.321353403771;5163.509466600667;5209.6874187548865;5239.738013099368;5242.501962313574;5281.52466278033;5503.174523821419;5583.553315734732;5585.832425027215;5587.413321601214;5598.384177740445;5730.885382292373;5731;5731.512821410185;5736.311642602873;5753.280839895013;5278.208268759717;5290.735463226862;5292.44429334922;5302.416734159239;5351.759170837322;5685.260916080966;5715.1713001614535;5756.30924289088;5772.278465191851;5807.390224026501;5595.328560572757;5602.691851948182;5617.38208797032;5626.212330273765;5646.632968857011;5559.360673522597;5657.858553536194;5682.829515114553;5685.687287199161;5690.459406356389;5494.862628434321;5636.943630563724;5644.604877658607;5653.802116925888;5658.462446067617;5527.50252477279;5566.415526369673;5584.748686309126;5591.440855914458;5628.155776633455;4717.905641887143;4735.384400028043;4737.526247375235;4746.430428348551;4778.37881075458;4048.08917993455;4049.7570145791346;4049.9392509112386;4076.184763047343;4108.096218831853;4583.564561366731;4671.6262698984;4730.62155027597;4736.052789442126;4798.640101992364;5725.799597014085;5738.856528586819;5745.88508229833;5771.59598828078;5786.363500014995;4770.451398089194;4779.235322348477;4792.305115758265;4793.544613261804;4823.879403014953;4926.310316555685;5032.270320803536;5054.82308119214;5063.746812659352;5065.949340506548;5171.095058364695;5237.2929654497675;5245.921311180412;5252.028374750684;5260.921086183634;5615.101583746581;5692.914606280992;5701.1448282756255;5706.629069110494;5754.769809207753;5209.4009188943755;5275.103232450416;5300.416954135119;5300.443453437333;5318.547923426398;5458.099413596871;5492.945070549403;5503.147012213113;5507.118860982224;5512.6692398456225;5573.749181286933;5602.327720673546;5617.157426386075;5629.155626656035;5630.352509461464;5365.436629153883;5421.2681288025615;5440.483154100354;5441.455854414685;5442.2108794225405;5441.972790136024;5447.645903016291;5464.28964234647;5473.616846820684;5508.394076651485;5310.628256022196;5341.732913354394;5346.144616861284;5397.433269506645;5446.673199607878;5453;5471.50756431923;5494.2857428534035;5502.58730595199;5545.251391062155;5396.541293990055;5417.5665946723375;5420.13277875538;5443.129099344086;5461.208124821958 09:42:41 INFO - PID 32747 | |1;ext.html;699.3181647893301;762.0322190817661;775.724617760695;957.2055194188824;958.5446912716457;32750.67249327506;33645.83177084114;33679.32641347172;33695.157621059516;33810.49284260738;34949.301013979704;35277;35322.823385883035;35407.64592354076;35444.82277588615;6575.3095924927675;6764.627945462998;6828.351306625887;6902.275261097588;6910.723571057151;6765.594064356154;6852;6855.211650660163;6858.897116543256;6866.690998905061;6831.487638427113;6883.862322753542;6887.48343874209;6898.034275201476;6906.136732908387;6788.694508747119;6818.829529261783;6838.760643377507;6843.863122737517;6872.347127022925;6470.611763294218;6475.902861457082;6509;6514.674266286666;6534.509911756637;31256.374872502423;31307.06078817639;31497.37005259882;31517.36965260682;31553.21116972071;3090.98454507726;3148.8583013764205;3153.0698443959086;3153.9684603153905;3173.079806856009;24885.12902048438;25007.12475063364;25097.49805003908;25110.12114575981;25203.62194567083;2851.8859245630356;2863.8997635082674;2865.426914617085;2900.3329234276025;2903.651561812575;125065;126215;136718;142047;142262;39697.80151099226;39739.60260397359;39786.403203951966;39961.80019099886;40032;40986.79506602508;41138.58861411407;41157;41257.58742412538;41285.380719289235;12901.612951611467;12908.870911290767;12929.353532323346;13016.609501714964;13019.349032548334;10503.684889453329;10526.052705242544;10541;10557.947210264054;10586.735331616772;12430.12989090773;12520.31138287403;12543.247405155538;12594.748105037848;12763.298018609066;4759.119562880878;4777.832775852898;4838.588719958772;4850.805967761321;4863.805447782049;891.22463456793;891.6745387933357;907.5462268865567;934.9065093490597;942.7548837302351;20573.382798516068;20854.06156722951;21142.78857211439;21174.894125529274;21189;987.0425687083517;991.9702408927744;992.8212921674168;999.2505620784411;1016.4968340671415;10641.627543035956;11199.496022678999;11211.215214935039;11274.605388811517;11323.886761132284;175731;176122;177097;177727;178169;40720;40747.18505629871;40783.49422827939;40800;40822.18355632871;1210.4371467267763;1248.6878280429892;1249.1505776072358;1249.1568191470722;1264.3172686749235;19425.902870485555;19799.505012374804;20924.267650632763;20981.636193647366;21215.36353909385;29778.10665680033;29842.850785745934;29918.25204369908;29965.70034299629;29985.700142998292;151488;152817;152968;153126;153367;27990.3002424941;28447.43105137927;28536.85731571329;29139.854300728362;29463.852680736458;36531.634683652825;36793.448098278015;36867;37103.62896371002;37220;25630.615540767278;27061;27323.59014614822;27343.316417089733;28216.15351539457;27127.457450850477;27256.72743272542;27467.450650987266;27987;28656.71343286624;31058.378832423678;31165.844170779;31241.37517249688;31252.218694532818;31346.05961821149;26164.86917565476;26453.33866653349;27262.182134535997;27318.453630927666;27441.17676469709;21459.248926287506;22269.331920042423;22775.886120569292;22897.88551057234;22956.655650165594 09:42:41 INFO - PID 32747 | |2;jquery.html;408.41392601616684;408.8364654138342;413.4191460997298;428.2441490768792;432.33204698740445;13390.12964157329;13393.263370514618;17000.57498562535;17005.574860628476;17090.14549272536;17714;18430.631387372243;18446.723299150523;18447.907760461178;18507.629847403045;5435.157550579656;5619.690916999563;5623.522000629951;5629.577781666391;5632.239647647556;5459.781608735646;5522;5523.502884740373;5548.9722551387185;5568;5489.58828087893;5524.751386187631;5525.806596769114;5536.861578460551;5543.889122217553;5260.316158899338;5374.193870919355;5398.2712333834825;5400.162974738922;5464.016477034133;4870.0746858096845;4888.486708895551;4895.828645997373;4906.533879281498;4934.284528743348;22111.33665990023;22273.22043728478;22374.328770136923;22400.991955361886;22406.439839003993;1652.1573997261482;1668.9582760430965;1677.4715964471275;1681.5039563328846;1682.5288919102547;14559.563213103624;14648.926755366156;14901.180435076067;15096.39614415433;15098.094114353175;1960.2257108442086;1970.2119152339035;2030.7258520099745;2048.528838367169;2062.5359294158843;99840.50079749628;102203.97796022019;102800;103314.48342758238;103442.48278758633;10653.627123050655;11045.171612128961;11161;11251.324920504796;11256.606018789467;15467;15497.302621382065;15597.454089107054;15638.9218053909;15647.608809779847;7499.287567681062;7628.466007379541;7631.885521717179;7702.653380597886;7734.226577342333;6861.725530978805;6889.414399776075;6934.16789985205;7002.579845209304;7045.612491312924;7084.149902011792;7140.464465165133;7180.874788141839;7257.82674961899;7268.709251629982;2007.8494112941296;2014.6977953306828;2026.6959956006717;2077.200277893022;2127.9148834046773;832.5129799067493;856.7643897927995;885.968991085309;891.22463456793;893.8346405914797;17390.565235869206;17413.65172696539;17510.38713645042;17820;18046.097695115193;874.711345256064;874.9825003499894;876.7808047988003;880.9036237624754;886.6320477001972;9329.207017403596;9795.963196493349;9863.112319891245;9907.504624768877;9974.152197063186;393725;394362;401727;401784;403158;81739;82054.58972705099;82259.5887020573;82572.17427825765;84810;1014.1785154025263;1031.8245898197324;1057.814882395593;1061.7186445591924;1066.5147357952112;17293.481195564153;18765.68640195173;19718.90140549288;19744.308949187285;19762.90118549398;47193.999999998625;47543;47605.52394476011;47846.76076619595;48374.75812620914;52777.47222527879;52928;53403;53605;53668.73165634147;8875.511846848485;9239.815203695754;9310.906890931004;9363.906360936577;9385.530723463662;15334.309956052228;15838.68322633564;16012.519624411287;16612.750808737637;16660.916695416447;13451.125676830974;13579.25314107694;14022.158670479805;14131.15213087218;14203.502877399242;11961.222520536137;12390.194637348544;12422.130450868352;12478.376081195722;12734.872651273368;14069.296535173406;14278.143311401349;14287.142771433748;14292.142471451747;14384.35270412813;9484.715458536255;9519.952400237955;9557.665481708107;9572.186364159124;9589.089036541518;13458.52895148665;13628.591142265748;13676.589702308947;13677.384517696528;13686.384112714753 09:42:41 INFO - PID 32747 | |3;mootools.html;1269.606422009177;1318.3276528970234;1329.8005299205117;1354.1468874609002;1360.8571100034494;9949.602015919363;10128.594856205744;10419.479026048695;10469.424181670014;10493.108085812695;10337.896621033806;10520.684379468628;10538.736531586714;10543.209259305564;10569.841452378221;2036.0735865181343;2071.1301253473575;2077.979220207801;2078.7423608716736;2080.1991233375184;1968.9507762305914;2028.077224862684;2028.8985550722405;2036.2669439001947;2042.5097976485686;1831.587892724133;1852.5831687870257;1852.833245007949;1858.6189831084596;1861.8045105263955;1850.9814901850943;1853.7868145163343;1856.4152292028036;1859.9256029758794;1863.1243315641696;1845.4832646858902;1917.990410047941;1924.8748831326059;1958.490792393988;1968.7145363922293;10168.237382196365;10235.79528409435;10240.641577544824;10249.897501024969;10266.7433314167;5226;5414.512693857571;5416.9729151353995;5433.723075077353;5441.7279136043435;3087.6603573606885;3204;3239.7894136881027;3243.2378391078078;3244.821534815584;1012.0840639221443;1030.07808011829;1043.4521876015076;1046.837740150278;1054.0618849224197;14529.273536323142;14538.563843084725;14714.926425367912;14732.484363047242;15178.571428571375;4734.257252500345;4751.3348131261655;4839.782209800567;4844.467108618049;4888.120138375127;11164.553417863195;11256.606018789304;11277.54889804415;11278.661640150809;11281.774364512663;5399.271098401666;5501.257330260443;5508.476694713996;5508.807191748269;5513.117901135799;4945.530174633404;5025.522575355335;5041.445441001487;5066.290719299301;5093.567046801063;3939.290927632996;3974.642282194616;3981.7013723970817;3990.74060186087;4075.1034772350035;1146.363768108691;1150.7180740718577;1158.3802665573878;1168.9649310520697;1169.6198735411026;685.2633419074515;704.6582407532343;708.3660124188925;720.0243669827413;727.1637616740791;5108.3103780989095;5210;5253.212018197224;5310.946890531122;5416.458354164631;547.9561635069185;557.4704031170404;561.5563704673344;566.9829905102854;570.3156212544963;3208.5828842250357;3230.353929214167;3340.711612545414;3464.566929133858;3787.3182827090836;11957.34234617087;12148.69628259283;12158.696032599255;12162.635120946386;13101.803472947913;11885.88114118865;12129.272243665408;12145.392730363623;12146.392680366123;12160.452779624939;6587.538872278895;7375.668094935633;7479.887801682979;7529;7624.885626715603;5822.505087067647;6002.879942401215;6156.6921653918025;6214.9067763984485;6328.0824280478155;10990.010899019127;11030.22788404804;11062.39156846349;11065.944670276596;11105;11377.2604780689;11409.258398204422;11441.427928603704;11456.484458199568;11459.942700286778;7909.564973926259;8045.195480451908;8070;8081.515109093473;8097.716579919675;9568.856467152858;9596.760080997752;9627.326087173831;9654.56554455037;9669.758256043655;7875.960620196863;7906.644201010853;7993.560354180576;8192.180781922;8401.243888050105;7706.460547761603;7850.371970242481;7903.644336005009;7978.3218426434405;7997.360211182975;6405.231372235362;6498.220213574401;6499.415052645285;6500.70746816385;6508.381703738138;4988.451270360185;5010;5036.320096786887;5050.873728156826;5135.589152867687;4732.47942726293;4792.472827988849;4904.632152588499;4924.655274130777;4928.0390323886495 09:42:41 INFO - PID 32747 | |4;prototype.html;345.18708441619987;362.21038136861637;363.20458196549555;366.11400411005366;374.3860069486045;5457.617966742329;5539.1968164616155;5582.832515024551;5599.664020158793;5620.831375058745;5361.169018802092;5427.158790387486;5435.510804027636;5449.155380915964;5450.073487507133;4132.628063474287;4143.627073563379;4158.438610787535;4159.70882038256;4179.582041795819;4184.518780340254;4188.97905510472;4190.329547272437;4196.223698615766;4216.198922204771;4147.419361289422;4153.6677065834665;4155.958440415588;4160.983287116846;4162.4796900387455;4148.23257697327;4156.189543039109;4158.750474971512;4160.854370097032;4176.665866730655;3646.6353364663587;3659.432787917877;3661.41417373219;3670.137517683342;3677.797721125337;5400.78396864125;5423.701696406696;5429.809956651498;5444.972775136139;5445.156000819879;4923.113839508887;4928.531789479994;4931.408231012266;4933.7286449245275;4941.616347422728;5783.40956237034;5821.563382746311;5822.184894114827;5825.650460972312;5839.7664093436215;4092.1201941582704;4115.8765237042935;4117.135401565675;4117.56765539617;4118.361653943613;5768.567357448208;6136.325004249529;6204.627722336674;6210.5715685392615;6215.384000159946;4141.130362623822;4167.541570427311;4191;4191.182719369694;4195.370694395804;4222.577742225752;4225.535191128974;4225.619694227473;4244.4932049122735;4247.405363249148;4640.141573808856;4847.491013443609;4849.69639421272;4852.272159176081;4856.41722993236;5778.104393818965;5787.2476578045425;5797.275340582427;5799.33307669615;5806.506446952057;1434.2470203143432;1439.6688761584894;1456.3446449097949;1457.9343929523197;1459.6861674739982;938.3853575907655;973.5424350555228;977.6578197630772;981.9607215711435;986.2307400227834;4996.400431948189;5004.499550044967;5009.7244651544515;5009.874753131128;5020.849374518771;5998.730057147439;6007.729652165663;6013.278406591149;6032.909506357408;6053.606515576474;4974.77613507393;4994.001199760062;5003;5013.448520662724;5013.774380152902;3172.6192856857324;3173.397054559626;3185.9044228672715;3209.4864821628425;3216.935661286761;5567.246317410003;5583.330000399978;5589.245451863946;5595.888082238333;5601.29983752031;6160.168377269101;6163.96918015416;6200.720967556471;6214.285357183891;6233.376662333821;5573.191887176336;5580.218769372291;5581.134924086773;5586.245856809279;5606.6636001840025;6009.699515024144;6030.336662966983;6042.365551617193;6051.636901785907;6068.7269072892705;5936.46571808522;5963.165156878127;5963.821085367446;5966.224390829338;5968.313643931004;5253.894922101613;5531.419200984;5549.5837812165055;5557.694326812064;5564.108203210928;4024.7987600620436;4024.8993775155855;4028.4964379452567;4028.9798551007057;4039.5758445362812;5971.522278217645;6010.909836352545;6020.4280593343565;6025.337212906665;6032.276126864805;5611.775528978795;5738.942610573841;5764.135379692912;5773.6824474654295;5801.506871915934;5767.625104368202;5782.190493330853;5784.768609255582;5791.478766910998;5802.303723553032;5695.0603150481365;5721.313442386941;5734.741936612779;5751.367349591458;5755.798547051;5839.883202336015;5853.795117170878;5869;5871.354151043296;5890.4698577128265;5619.719014049199;5690.630109042899;5708.514776244066;5718.684702518361;5743.8564035899435 09:42:41 INFO - PID 32747 | |5;yui.html;682.4165338635466;687.5702685821361;689.2969171445126;700.9859802803944;703;13092.083554151213;13485.460581576737;13523.391447384854;15657.138857362841;16802.579935501617;15370.462033828819;15378.154201518912;15417.383304667828;15499.302531386087;15619.921900390482;888.1917455115846;900.9369344145913;905.3617199874072;905.642271302835;906.3610154840821;888.205056474455;911.7583840282331;914.5153068873508;915.5193523400202;932.8460803967371;970.5438443931341;978.8580655804903;978.9657361992332;979.5738853598707;980.0934135924277;965.1217392173124;966.1787480641469;968.7142293023575;970.9660161894335;974.990250097497;701.7929710735294;706.6113637499407;707.7487491940338;709.2588245283639;712.6436781609195;14038;14362.066465679802;14498.710025799424;14558.854411455855;14604.561863144123;14304.570862874027;14653.12081275127;14721.779173312301;14757.704845903128;14760.630984225372;13090.214587124803;13176.86823131766;13289;13405.731885362238;13457.259850708208;3063.6170478690165;3070.7543396528226;3077.753779697619;3078.5074388097796;3084.706952839477;83942.58028709878;84087;84242.57878710628;85430.14569854284;86240.13759862384;12002.699932501582;12080.697982550506;12260.386980650932;12263.93868030654;12267.325297108744;19836.60326793456;20338.186472540932;20531.692024619642;20590.176392944115;20654.277100301417;5941.732622032019;6115.571909966348;6147.569670123048;6256.499480041586;6274.6548939807835;3100.798448100866;3165.240342317827;3192.9361412771614;3196.6803319667847;3200.2799370141997;3508.9122771930397;3557.0395993081725;3562.8574857005947;3563.572371315407;3575.66031227033;700.5481464455398;700.6321681117454;701.824543864034;705.4497491956282;708.2068083746237;589.0443726826979;606.266417634667;607.8510764862637;623.9875202496015;628.7327885648581;9722.9027709722;10577.048065674126;10884.945575272232;11019.228653994303;11255.155863310121;604.4952464692032;610.8045425463808;620.2773768559578;635.4947816485904;643.2955913274957;4499.55004499554;4796.856094317176;4835.734034628129;4853.272009198648;4972.955679307386;86921.56539217263;87512;87765.56117219373;88634;89333;77868;78261;78266.21733782589;78321;78887.60556197182;61524.692376536936;63629;64152.358476414636;67860.64278714398;71085;9889.406635601887;10125.848112278174;10227.94886025565;10328.638497652546;10459;27076.1877143686;27374.17877463679;27517.449651007268;27821.02626408066;28695.282617934718;33824.830875845466;34337;34348.31303373868;34516.65483345235;34783.82608086943;13707.177569345871;13777.448902043807;14083.929580352033;14240;14302.068076044177;15514.456994005155;15570.532884013497;16486.917565412095;16502.42241521541;16762.748558771873;14318.427262909783;14666.926665366605;14740.778888316469;14752.704945901236;14943.701125977203;13944.651383715489;14244.359003844645;14453.277336132942;14893.106413615218;15118;13602.863971360555;13977.790333144807;14117.576472705836;14172.858271417153;15293.388264469297;10153.79692406133;10300.484975751033;10581.418022008864;10756.623518176826;10921.399323037309;11776.175667703179;12303.93848030754;12733.681657958625;12826.55107071248;12897.551959376508 09:42:41 INFO - PID 32747 | __end_tp_report 09:42:41 INFO - PID 32747 | __start_cc_report 09:42:41 INFO - PID 32747 | _x_x_mozilla_cycle_collect,402 09:42:41 INFO - PID 32747 | __end_cc_report 09:42:41 INFO - PID 32747 | __startTimestamp1496335361247__endTimestamp 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | ------- Summary: start ------- 09:42:41 INFO - PID 32747 | Number of tests: 6 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | [#0] dojo.html Cycles:165 Average:5154.35 Median:5302.42 stddev:607.03 (11.4%) stddev-sans-first:577.40 09:42:41 INFO - PID 32747 | Values: 2694.2 2718.4 2725.9 2738.1 2751.6 5171.0 5224.7 5241.9 5265.2 5271.5 5146.5 5192.8 5253.2 5283.5 5292.9 4441.9 4621.9 4627.4 4670.0 4674.4 4675.9 4694.6 4710.7 4717.7 4720.3 4512.3 4620.2 4623.5 4646.2 4684.5 4672.5 4674.7 4678.6 4703.7 4727.6 4589.3 4639.8 4643.1 4661.3 4680.3 5163.5 5209.7 5239.7 5242.5 5281.5 5503.2 5583.6 5585.8 5587.4 5598.4 5730.9 5731.0 5731.5 5736.3 5753.3 5278.2 5290.7 5292.4 5302.4 5351.8 5685.3 5715.2 5756.3 5772.3 5807.4 5595.3 5602.7 5617.4 5626.2 5646.6 5559.4 5657.9 5682.8 5685.7 5690.5 5494.9 5636.9 5644.6 5653.8 5658.5 5527.5 5566.4 5584.7 5591.4 5628.2 4717.9 4735.4 4737.5 4746.4 4778.4 4048.1 4049.8 4049.9 4076.2 4108.1 4583.6 4671.6 4730.6 4736.1 4798.6 5725.8 5738.9 5745.9 5771.6 5786.4 4770.5 4779.2 4792.3 4793.5 4823.9 4926.3 5032.3 5054.8 5063.7 5065.9 5171.1 5237.3 5245.9 5252.0 5260.9 5615.1 5692.9 5701.1 5706.6 5754.8 5209.4 5275.1 5300.4 5300.4 5318.5 5458.1 5492.9 5503.1 5507.1 5512.7 5573.7 5602.3 5617.2 5629.2 5630.4 5365.4 5421.3 5440.5 5441.5 5442.2 5442.0 5447.6 5464.3 5473.6 5508.4 5310.6 5341.7 5346.1 5397.4 5446.7 5453.0 5471.5 5494.3 5502.6 5545.3 5396.5 5417.6 5420.1 5443.1 5461.2 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | [#1] ext.html Cycles:180 Average:29986.80 Median:16538.34 stddev:40191.79 (243.0%) stddev-sans-first:40244.37 09:42:41 INFO - PID 32747 | Values: 699.3 762.0 775.7 957.2 958.5 32750.7 33645.8 33679.3 33695.2 33810.5 34949.3 35277.0 35322.8 35407.6 35444.8 6575.3 6764.6 6828.4 6902.3 6910.7 6765.6 6852.0 6855.2 6858.9 6866.7 6831.5 6883.9 6887.5 6898.0 6906.1 6788.7 6818.8 6838.8 6843.9 6872.3 6470.6 6475.9 6509.0 6514.7 6534.5 31256.4 31307.1 31497.4 31517.4 31553.2 3091.0 3148.9 3153.1 3154.0 3173.1 24885.1 25007.1 25097.5 25110.1 25203.6 2851.9 2863.9 2865.4 2900.3 2903.7 125065.0 126215.0 136718.0 142047.0 142262.0 39697.8 39739.6 39786.4 39961.8 40032.0 40986.8 41138.6 41157.0 41257.6 41285.4 12901.6 12908.9 12929.4 13016.6 13019.3 10503.7 10526.1 10541.0 10557.9 10586.7 12430.1 12520.3 12543.2 12594.7 12763.3 4759.1 4777.8 4838.6 4850.8 4863.8 891.2 891.7 907.5 934.9 942.8 20573.4 20854.1 21142.8 21174.9 21189.0 987.0 992.0 992.8 999.3 1016.5 10641.6 11199.5 11211.2 11274.6 11323.9 175731.0 176122.0 177097.0 177727.0 178169.0 40720.0 40747.2 40783.5 40800.0 40822.2 1210.4 1248.7 1249.2 1249.2 1264.3 19425.9 19799.5 20924.3 20981.6 21215.4 29778.1 29842.9 29918.3 29965.7 29985.7 151488.0 152817.0 152968.0 153126.0 153367.0 27990.3 28447.4 28536.9 29139.9 29463.9 36531.6 36793.4 36867.0 37103.6 37220.0 25630.6 27061.0 27323.6 27343.3 28216.2 27127.5 27256.7 27467.5 27987.0 28656.7 31058.4 31165.8 31241.4 31252.2 31346.1 26164.9 26453.3 27262.2 27318.5 27441.2 21459.2 22269.3 22775.9 22897.9 22956.7 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | [#2] jquery.html Cycles:180 Average:27105.35 Median:398044.50 stddev:66659.77 (16.7%) stddev-sans-first:66816.63 09:42:41 INFO - PID 32747 | Values: 408.4 408.8 413.4 428.2 432.3 13390.1 13393.3 17000.6 17005.6 17090.1 17714.0 18430.6 18446.7 18447.9 18507.6 5435.2 5619.7 5623.5 5629.6 5632.2 5459.8 5522.0 5523.5 5549.0 5568.0 5489.6 5524.8 5525.8 5536.9 5543.9 5260.3 5374.2 5398.3 5400.2 5464.0 4870.1 4888.5 4895.8 4906.5 4934.3 22111.3 22273.2 22374.3 22401.0 22406.4 1652.2 1669.0 1677.5 1681.5 1682.5 14559.6 14648.9 14901.2 15096.4 15098.1 1960.2 1970.2 2030.7 2048.5 2062.5 99840.5 102204.0 102800.0 103314.5 103442.5 10653.6 11045.2 11161.0 11251.3 11256.6 15467.0 15497.3 15597.5 15638.9 15647.6 7499.3 7628.5 7631.9 7702.7 7734.2 6861.7 6889.4 6934.2 7002.6 7045.6 7084.1 7140.5 7180.9 7257.8 7268.7 2007.8 2014.7 2026.7 2077.2 2127.9 832.5 856.8 886.0 891.2 893.8 17390.6 17413.7 17510.4 17820.0 18046.1 874.7 875.0 876.8 880.9 886.6 9329.2 9796.0 9863.1 9907.5 9974.2 393725.0 394362.0 401727.0 401784.0 403158.0 81739.0 82054.6 82259.6 82572.2 84810.0 1014.2 1031.8 1057.8 1061.7 1066.5 17293.5 18765.7 19718.9 19744.3 19762.9 47194.0 47543.0 47605.5 47846.8 48374.8 52777.5 52928.0 53403.0 53605.0 53668.7 8875.5 9239.8 9310.9 9363.9 9385.5 15334.3 15838.7 16012.5 16612.8 16660.9 13451.1 13579.3 14022.2 14131.2 14203.5 11961.2 12390.2 12422.1 12478.4 12734.9 14069.3 14278.1 14287.1 14292.1 14384.4 9484.7 9520.0 9557.7 9572.2 9589.1 13458.5 13628.6 13676.6 13677.4 13686.4 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | [#3] mootools.html Cycles:180 Average:6067.33 Median:3292.77 stddev:3934.20 (119.5%) stddev-sans-first:3928.72 09:42:41 INFO - PID 32747 | Values: 1269.6 1318.3 1329.8 1354.1 1360.9 9949.6 10128.6 10419.5 10469.4 10493.1 10337.9 10520.7 10538.7 10543.2 10569.8 2036.1 2071.1 2078.0 2078.7 2080.2 1969.0 2028.1 2028.9 2036.3 2042.5 1831.6 1852.6 1852.8 1858.6 1861.8 1851.0 1853.8 1856.4 1859.9 1863.1 1845.5 1918.0 1924.9 1958.5 1968.7 10168.2 10235.8 10240.6 10249.9 10266.7 5226.0 5414.5 5417.0 5433.7 5441.7 3087.7 3204.0 3239.8 3243.2 3244.8 1012.1 1030.1 1043.5 1046.8 1054.1 14529.3 14538.6 14714.9 14732.5 15178.6 4734.3 4751.3 4839.8 4844.5 4888.1 11164.6 11256.6 11277.5 11278.7 11281.8 5399.3 5501.3 5508.5 5508.8 5513.1 4945.5 5025.5 5041.4 5066.3 5093.6 3939.3 3974.6 3981.7 3990.7 4075.1 1146.4 1150.7 1158.4 1169.0 1169.6 685.3 704.7 708.4 720.0 727.2 5108.3 5210.0 5253.2 5310.9 5416.5 548.0 557.5 561.6 567.0 570.3 3208.6 3230.4 3340.7 3464.6 3787.3 11957.3 12148.7 12158.7 12162.6 13101.8 11885.9 12129.3 12145.4 12146.4 12160.5 6587.5 7375.7 7479.9 7529.0 7624.9 5822.5 6002.9 6156.7 6214.9 6328.1 10990.0 11030.2 11062.4 11065.9 11105.0 11377.3 11409.3 11441.4 11456.5 11459.9 7909.6 8045.2 8070.0 8081.5 8097.7 9568.9 9596.8 9627.3 9654.6 9669.8 7876.0 7906.6 7993.6 8192.2 8401.2 7706.5 7850.4 7903.6 7978.3 7997.4 6405.2 6498.2 6499.4 6500.7 6508.4 4988.5 5010.0 5036.3 5050.9 5135.6 4732.5 4792.5 4904.6 4924.7 4928.0 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | [#4] prototype.html Cycles:180 Average:4790.19 Median:5453.85 stddev:1420.72 (26.0%) stddev-sans-first:1384.97 09:42:41 INFO - PID 32747 | Values: 345.2 362.2 363.2 366.1 374.4 5457.6 5539.2 5582.8 5599.7 5620.8 5361.2 5427.2 5435.5 5449.2 5450.1 4132.6 4143.6 4158.4 4159.7 4179.6 4184.5 4189.0 4190.3 4196.2 4216.2 4147.4 4153.7 4156.0 4161.0 4162.5 4148.2 4156.2 4158.8 4160.9 4176.7 3646.6 3659.4 3661.4 3670.1 3677.8 5400.8 5423.7 5429.8 5445.0 5445.2 4923.1 4928.5 4931.4 4933.7 4941.6 5783.4 5821.6 5822.2 5825.7 5839.8 4092.1 4115.9 4117.1 4117.6 4118.4 5768.6 6136.3 6204.6 6210.6 6215.4 4141.1 4167.5 4191.0 4191.2 4195.4 4222.6 4225.5 4225.6 4244.5 4247.4 4640.1 4847.5 4849.7 4852.3 4856.4 5778.1 5787.2 5797.3 5799.3 5806.5 1434.2 1439.7 1456.3 1457.9 1459.7 938.4 973.5 977.7 982.0 986.2 4996.4 5004.5 5009.7 5009.9 5020.8 5998.7 6007.7 6013.3 6032.9 6053.6 4974.8 4994.0 5003.0 5013.4 5013.8 3172.6 3173.4 3185.9 3209.5 3216.9 5567.2 5583.3 5589.2 5595.9 5601.3 6160.2 6164.0 6200.7 6214.3 6233.4 5573.2 5580.2 5581.1 5586.2 5606.7 6009.7 6030.3 6042.4 6051.6 6068.7 5936.5 5963.2 5963.8 5966.2 5968.3 5253.9 5531.4 5549.6 5557.7 5564.1 4024.8 4024.9 4028.5 4029.0 4039.6 5971.5 6010.9 6020.4 6025.3 6032.3 5611.8 5738.9 5764.1 5773.7 5801.5 5767.6 5782.2 5784.8 5791.5 5802.3 5695.1 5721.3 5734.7 5751.4 5755.8 5839.9 5853.8 5869.0 5871.4 5890.5 5619.7 5690.6 5708.5 5718.7 5743.9 09:42:41 INFO - PID 32747 | 09:42:41 INFO - PID 32747 | [#5] yui.html Cycles:180 Average:17476.25 Median:3194.81 stddev:23420.69 (733.1%) stddev-sans-first:23452.44 09:42:41 INFO - PID 32747 | Values: 682.4 687.6 689.3 701.0 703.0 13092.1 13485.5 13523.4 15657.1 16802.6 15370.5 15378.2 15417.4 15499.3 15619.9 888.2 900.9 905.4 905.6 906.4 888.2 911.8 914.5 915.5 932.8 970.5 978.9 979.0 979.6 980.1 965.1 966.2 968.7 971.0 975.0 701.8 706.6 707.7 709.3 712.6 14038.0 14362.1 14498.7 14558.9 14604.6 14304.6 14653.1 14721.8 14757.7 14760.6 13090.2 13176.9 13289.0 13405.7 13457.3 3063.6 3070.8 3077.8 3078.5 3084.7 83942.6 84087.0 84242.6 85430.1 86240.1 12002.7 12080.7 12260.4 12263.9 12267.3 19836.6 20338.2 20531.7 20590.2 20654.3 5941.7 6115.6 6147.6 6256.5 6274.7 3100.8 3165.2 3192.9 3196.7 3200.3 3508.9 3557.0 3562.9 3563.6 3575.7 700.5 700.6 701.8 705.4 708.2 589.0 606.3 607.9 624.0 628.7 9722.9 10577.0 10884.9 11019.2 11255.2 604.5 610.8 620.3 635.5 643.3 4499.6 4796.9 4835.7 4853.3 4973.0 86921.6 87512.0 87765.6 88634.0 89333.0 77868.0 78261.0 78266.2 78321.0 78887.6 61524.7 63629.0 64152.4 67860.6 71085.0 9889.4 10125.8 10227.9 10328.6 10459.0 27076.2 27374.2 27517.4 27821.0 28695.3 33824.8 34337.0 34348.3 34516.7 34783.8 13707.2 13777.4 14083.9 14240.0 14302.1 15514.5 15570.5 16486.9 16502.4 16762.7 14318.4 14666.9 14740.8 14752.7 14943.7 13944.7 14244.4 14453.3 14893.1 15118.0 13602.9 13977.8 14117.6 14172.9 15293.4 10153.8 10300.5 10581.4 10756.6 10921.4 11776.2 12303.9 12733.7 12826.6 12897.6 09:42:41 INFO - PID 32747 | -------- Summary: end -------- 09:42:41 INFO - PID 32747 | 09:42:42 INFO - TEST-INFO | 32747: exit 0 09:42:42 INFO - TEST-OK | dromaeo_css | took 1147039ms 09:42:42 INFO - TEST-START | kraken 09:42:42 INFO - operating with platform_type : linux_ 09:42:42 INFO - Initialising browser for kraken test... 09:42:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47784/getInfo.html -profile /tmp/tmpDJwPp9/profile 09:42:42 INFO - TEST-INFO | started process 695 (/builds/slave/test/build/application/firefox/firefox http://localhost:47784/getInfo.html) 09:43:17 INFO - TEST-INFO | 695: killed by SIGTERM 09:43:17 INFO - Browser initialized. 09:43:17 INFO - Running cycle 1/1 for kraken test... 09:43:17 INFO - TEST-INFO | started process 909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDJwPp9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:29 INFO - PID 909 | RSS: Main: 184475648 09:43:29 INFO - PID 909 | 09:43:31 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47784/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:32 INFO - PID 909 | RSS: Main: 187482112 09:43:32 INFO - PID 909 | 09:43:35 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47784/tests/kraken/driver.html?testName=audio-dft) 09:43:36 INFO - PID 909 | RSS: Main: 187166720 09:43:36 INFO - PID 909 | 09:43:39 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47784/tests/kraken/driver.html?testName=audio-fft) 09:43:39 INFO - PID 909 | RSS: Main: 181661696 09:43:39 INFO - PID 909 | 09:43:41 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47784/tests/kraken/driver.html?testName=audio-oscillator) 09:43:42 INFO - PID 909 | RSS: Main: 182300672 09:43:42 INFO - PID 909 | 09:43:44 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47784/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:45 INFO - PID 909 | RSS: Main: 182067200 09:43:45 INFO - PID 909 | 09:43:48 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47784/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:48 INFO - PID 909 | RSS: Main: 183762944 09:43:48 INFO - PID 909 | 09:43:52 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47784/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:53 INFO - PID 909 | RSS: Main: 182353920 09:43:53 INFO - PID 909 | 09:43:55 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47784/tests/kraken/driver.html?testName=json-parse-financial) 09:43:56 INFO - PID 909 | RSS: Main: 183209984 09:43:56 INFO - PID 909 | 09:43:58 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47784/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:58 INFO - PID 909 | RSS: Main: 183042048 09:43:58 INFO - PID 909 | 09:44:00 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:01 INFO - PID 909 | RSS: Main: 183238656 09:44:01 INFO - PID 909 | 09:44:03 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:04 INFO - PID 909 | RSS: Main: 182984704 09:44:04 INFO - PID 909 | 09:44:07 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:07 INFO - PID 909 | RSS: Main: 182902784 09:44:07 INFO - PID 909 | 09:44:10 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:11 INFO - PID 909 | RSS: Main: 182583296 09:44:11 INFO - PID 909 | 09:44:13 INFO - PID 909 | Cycle 1(1): loaded http://localhost:47784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47784/tests/kraken/driver.html?testName=ai-astar) 09:44:13 INFO - PID 909 | RSS: Main: 184074240 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | __start_tp_report 09:44:13 INFO - PID 909 | _x_x_mozilla_page_load 09:44:13 INFO - PID 909 | _x_x_mozilla_page_load_details 09:44:13 INFO - PID 909 | |i|pagename|runs| 09:44:13 INFO - PID 909 | |0;ai-astar;105;111;110;112;111;111;111;111;111;111 09:44:13 INFO - PID 909 | |1;audio-beat-detection;153;123;137;176;125;128;134;123;151;127 09:44:13 INFO - PID 909 | |2;audio-dft;165;164;163;163;167;169;175;164;164;162 09:44:13 INFO - PID 909 | |3;audio-fft;79;78;76;102;76;76;76;79;96;75 09:44:13 INFO - PID 909 | |4;audio-oscillator;83;83;108;83;83;83;99;83;85;103 09:44:13 INFO - PID 909 | |5;imaging-gaussian-blur;114;115;113;114;115;115;113;113;113;113 09:44:13 INFO - PID 909 | |6;imaging-darkroom;150;152;150;153;151;152;152;151;153;154 09:44:13 INFO - PID 909 | |7;imaging-desaturate;95;96;94;94;95;95;94;95;95;95 09:44:13 INFO - PID 909 | |8;json-parse-financial;54;56;54;55;55;56;58;55;56;56 09:44:13 INFO - PID 909 | |9;json-stringify-tinderbox;56;55;57;56;55;56;56;55;56;56 09:44:13 INFO - PID 909 | |10;stanford-crypto-aes;88;88;95;87;86;88;90;88;128;86 09:44:13 INFO - PID 909 | |11;stanford-crypto-ccm;129;145;134;143;135;137;129;129;130;146 09:44:13 INFO - PID 909 | |12;stanford-crypto-pbkdf2;192;195;195;193;196;196;196;207;193;192 09:44:13 INFO - PID 909 | |13;stanford-crypto-sha256-iterative;73;73;74;77;73;72;71;77;70;74 09:44:13 INFO - PID 909 | __end_tp_report 09:44:13 INFO - PID 909 | __start_cc_report 09:44:13 INFO - PID 909 | _x_x_mozilla_cycle_collect,1070 09:44:13 INFO - PID 909 | __end_cc_report 09:44:13 INFO - PID 909 | __startTimestamp1496335453633__endTimestamp 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | ------- Summary: start ------- 09:44:13 INFO - PID 909 | Number of tests: 14 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.96 (1.8%) stddev-sans-first:0.50 09:44:13 INFO - PID 909 | Values: 105.0 111.0 110.0 112.0 111.0 111.0 111.0 111.0 111.0 111.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:135.50 stddev:17.30 (12.8%) stddev-sans-first:17.44 09:44:13 INFO - PID 909 | Values: 153.0 123.0 137.0 176.0 125.0 128.0 134.0 123.0 151.0 127.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#2] audio-dft Cycles:10 Average:165.60 Median:164.50 stddev:3.89 (2.4%) stddev-sans-first:4.12 09:44:13 INFO - PID 909 | Values: 165.0 164.0 163.0 163.0 167.0 169.0 175.0 164.0 164.0 162.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:9.53 (12.4%) stddev-sans-first:10.08 09:44:13 INFO - PID 909 | Values: 79.0 78.0 76.0 102.0 76.0 76.0 76.0 79.0 96.0 75.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.00 stddev:9.93 (12.0%) stddev-sans-first:10.27 09:44:13 INFO - PID 909 | Values: 83.0 83.0 108.0 83.0 83.0 83.0 99.0 83.0 85.0 103.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 09:44:13 INFO - PID 909 | Values: 114.0 115.0 113.0 114.0 115.0 115.0 113.0 113.0 113.0 113.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:152.00 stddev:1.32 (0.9%) stddev-sans-first:1.22 09:44:13 INFO - PID 909 | Values: 150.0 152.0 150.0 153.0 151.0 152.0 152.0 151.0 153.0 154.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:44:13 INFO - PID 909 | Values: 95.0 96.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.18 (2.1%) stddev-sans-first:1.12 09:44:13 INFO - PID 909 | Values: 54.0 56.0 54.0 55.0 55.0 56.0 58.0 55.0 56.0 56.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 09:44:13 INFO - PID 909 | Values: 56.0 55.0 57.0 56.0 55.0 56.0 56.0 55.0 56.0 56.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:88.00 stddev:12.77 (14.5%) stddev-sans-first:13.45 09:44:13 INFO - PID 909 | Values: 88.0 88.0 95.0 87.0 86.0 88.0 90.0 88.0 128.0 86.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:136.00 stddev:6.82 (5.0%) stddev-sans-first:6.78 09:44:13 INFO - PID 909 | Values: 129.0 145.0 134.0 143.0 135.0 137.0 129.0 129.0 130.0 146.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.50 Median:195.50 stddev:4.35 (2.2%) stddev-sans-first:4.43 09:44:13 INFO - PID 909 | Values: 192.0 195.0 195.0 193.0 196.0 196.0 196.0 207.0 193.0 192.0 09:44:13 INFO - PID 909 | 09:44:13 INFO - PID 909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.50 stddev:2.27 (3.1%) stddev-sans-first:2.40 09:44:13 INFO - PID 909 | Values: 73.0 73.0 74.0 77.0 73.0 72.0 71.0 77.0 70.0 74.0 09:44:13 INFO - PID 909 | -------- Summary: end -------- 09:44:13 INFO - PID 909 | 09:44:14 INFO - TEST-INFO | 909: exit 0 09:44:14 INFO - TEST-OK | kraken | took 92674ms 09:44:14 INFO - SUITE-END | took 1239s 09:44:15 INFO - Completed test suite (00:20:40) 09:44:15 INFO - javascript benchmark 09:44:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6770.864751607561, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2694.232143839006, 2718.4427192425555, 2725.918222453326, 2738.1101142128814, 2751.614773931649, 5170.991656626959, 5224.686518808874, 5241.947580524194, 5265.236540701596, 5271.525562699357, 5146.45962173971, 5192.844214673556, 5253.159494480874, 5283.471652834714, 5292.920606190901, 4441.947848416755, 4621.907561848761, 4627.3521706961055, 4670.042641258534, 4674.368960190382, 4675.88310292242, 4694.600958918479, 4710.74090924999, 4717.716936983792, 4720.3391525186325, 4512.323151527265, 4620.214563524209, 4623.537646235383, 4646.233371493699, 4684.508126646687, 4672.462666793328, 4674.719516829001, 4678.6491013174145, 4703.717776933361, 4727.57451829337, 4589.311603259504, 4639.76801159944, 4643.094596553673, 4661.3241080043545, 4680.321353403771, 5163.509466600667, 5209.6874187548865, 5239.738013099368, 5242.501962313574, 5281.52466278033, 5503.174523821419, 5583.553315734732, 5585.832425027215, 5587.413321601214, 5598.384177740445, 5730.885382292373, 5731.0, 5731.512821410185, 5736.311642602873, 5753.280839895013, 5278.208268759717, 5290.735463226862, 5292.44429334922, 5302.416734159239, 5351.759170837322, 5685.260916080966, 5715.1713001614535, 5756.30924289088, 5772.278465191851, 5807.390224026501, 5595.328560572757, 5602.691851948182, 5617.38208797032, 5626.212330273765, 5646.632968857011, 5559.360673522597, 5657.858553536194, 5682.829515114553, 5685.687287199161, 5690.459406356389, 5494.862628434321, 5636.943630563724, 5644.604877658607, 5653.802116925888, 5658.462446067617, 5527.50252477279, 5566.415526369673, 5584.748686309126, 5591.440855914458, 5628.155776633455, 4717.905641887143, 4735.384400028043, 4737.526247375235, 4746.430428348551, 4778.37881075458, 4048.08917993455, 4049.7570145791346, 4049.9392509112386, 4076.184763047343, 4108.096218831853, 4583.564561366731, 4671.6262698984, 4730.62155027597, 4736.052789442126, 4798.640101992364, 5725.799597014085, 5738.856528586819, 5745.88508229833, 5771.59598828078, 5786.363500014995, 4770.451398089194, 4779.235322348477, 4792.305115758265, 4793.544613261804, 4823.879403014953, 4926.310316555685, 5032.270320803536, 5054.82308119214, 5063.746812659352, 5065.949340506548, 5171.095058364695, 5237.2929654497675, 5245.921311180412, 5252.028374750684, 5260.921086183634, 5615.101583746581, 5692.914606280992, 5701.1448282756255, 5706.629069110494, 5754.769809207753, 5209.4009188943755, 5275.103232450416, 5300.416954135119, 5300.443453437333, 5318.547923426398, 5458.099413596871, 5492.945070549403, 5503.147012213113, 5507.118860982224, 5512.6692398456225, 5573.749181286933, 5602.327720673546, 5617.157426386075, 5629.155626656035, 5630.352509461464, 5365.436629153883, 5421.2681288025615, 5440.483154100354, 5441.455854414685, 5442.2108794225405, 5441.972790136024, 5447.645903016291, 5464.28964234647, 5473.616846820684, 5508.394076651485, 5310.628256022196, 5341.732913354394, 5346.144616861284, 5397.433269506645, 5446.673199607878, 5453.0, 5471.50756431923, 5494.2857428534035, 5502.58730595199, 5545.251391062155, 5396.541293990055, 5417.5665946723375, 5420.13277875538, 5443.129099344086, 5461.208124821958], "value": 5110.19812302033, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.3181647893301, 762.0322190817661, 775.724617760695, 957.2055194188824, 958.5446912716457, 32750.67249327506, 33645.83177084114, 33679.32641347172, 33695.157621059516, 33810.49284260738, 34949.301013979704, 35277.0, 35322.823385883035, 35407.64592354076, 35444.82277588615, 6575.3095924927675, 6764.627945462998, 6828.351306625887, 6902.275261097588, 6910.723571057151, 6765.594064356154, 6852.0, 6855.211650660163, 6858.897116543256, 6866.690998905061, 6831.487638427113, 6883.862322753542, 6887.48343874209, 6898.034275201476, 6906.136732908387, 6788.694508747119, 6818.829529261783, 6838.760643377507, 6843.863122737517, 6872.347127022925, 6470.611763294218, 6475.902861457082, 6509.0, 6514.674266286666, 6534.509911756637, 31256.374872502423, 31307.06078817639, 31497.37005259882, 31517.36965260682, 31553.21116972071, 3090.98454507726, 3148.8583013764205, 3153.0698443959086, 3153.9684603153905, 3173.079806856009, 24885.12902048438, 25007.12475063364, 25097.49805003908, 25110.12114575981, 25203.62194567083, 2851.8859245630356, 2863.8997635082674, 2865.426914617085, 2900.3329234276025, 2903.651561812575, 125065.0, 126215.0, 136718.0, 142047.0, 142262.0, 39697.80151099226, 39739.60260397359, 39786.403203951966, 39961.80019099886, 40032.0, 40986.79506602508, 41138.58861411407, 41157.0, 41257.58742412538, 41285.380719289235, 12901.612951611467, 12908.870911290767, 12929.353532323346, 13016.609501714964, 13019.349032548334, 10503.684889453329, 10526.052705242544, 10541.0, 10557.947210264054, 10586.735331616772, 12430.12989090773, 12520.31138287403, 12543.247405155538, 12594.748105037848, 12763.298018609066, 4759.119562880878, 4777.832775852898, 4838.588719958772, 4850.805967761321, 4863.805447782049, 891.22463456793, 891.6745387933357, 907.5462268865567, 934.9065093490597, 942.7548837302351, 20573.382798516068, 20854.06156722951, 21142.78857211439, 21174.894125529274, 21189.0, 987.0425687083517, 991.9702408927744, 992.8212921674168, 999.2505620784411, 1016.4968340671415, 10641.627543035956, 11199.496022678999, 11211.215214935039, 11274.605388811517, 11323.886761132284, 175731.0, 176122.0, 177097.0, 177727.0, 178169.0, 40720.0, 40747.18505629871, 40783.49422827939, 40800.0, 40822.18355632871, 1210.4371467267763, 1248.6878280429892, 1249.1505776072358, 1249.1568191470722, 1264.3172686749235, 19425.902870485555, 19799.505012374804, 20924.267650632763, 20981.636193647366, 21215.36353909385, 29778.10665680033, 29842.850785745934, 29918.25204369908, 29965.70034299629, 29985.700142998292, 151488.0, 152817.0, 152968.0, 153126.0, 153367.0, 27990.3002424941, 28447.43105137927, 28536.85731571329, 29139.854300728362, 29463.852680736458, 36531.634683652825, 36793.448098278015, 36867.0, 37103.62896371002, 37220.0, 25630.615540767278, 27061.0, 27323.59014614822, 27343.316417089733, 28216.15351539457, 27127.457450850477, 27256.72743272542, 27467.450650987266, 27987.0, 28656.71343286624, 31058.378832423678, 31165.844170779, 31241.37517249688, 31252.218694532818, 31346.05961821149, 26164.86917565476, 26453.33866653349, 27262.182134535997, 27318.453630927666, 27441.17676469709, 21459.248926287506, 22269.331920042423, 22775.886120569292, 22897.88551057234, 22956.655650165594], "value": 14389.331831046014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.41392601616684, 408.8364654138342, 413.4191460997298, 428.2441490768792, 432.33204698740445, 13390.12964157329, 13393.263370514618, 17000.57498562535, 17005.574860628476, 17090.14549272536, 17714.0, 18430.631387372243, 18446.723299150523, 18447.907760461178, 18507.629847403045, 5435.157550579656, 5619.690916999563, 5623.522000629951, 5629.577781666391, 5632.239647647556, 5459.781608735646, 5522.0, 5523.502884740373, 5548.9722551387185, 5568.0, 5489.58828087893, 5524.751386187631, 5525.806596769114, 5536.861578460551, 5543.889122217553, 5260.316158899338, 5374.193870919355, 5398.2712333834825, 5400.162974738922, 5464.016477034133, 4870.0746858096845, 4888.486708895551, 4895.828645997373, 4906.533879281498, 4934.284528743348, 22111.33665990023, 22273.22043728478, 22374.328770136923, 22400.991955361886, 22406.439839003993, 1652.1573997261482, 1668.9582760430965, 1677.4715964471275, 1681.5039563328846, 1682.5288919102547, 14559.563213103624, 14648.926755366156, 14901.180435076067, 15096.39614415433, 15098.094114353175, 1960.2257108442086, 1970.2119152339035, 2030.7258520099745, 2048.528838367169, 2062.5359294158843, 99840.50079749628, 102203.97796022019, 102800.0, 103314.48342758238, 103442.48278758633, 10653.627123050655, 11045.171612128961, 11161.0, 11251.324920504796, 11256.606018789467, 15467.0, 15497.302621382065, 15597.454089107054, 15638.9218053909, 15647.608809779847, 7499.287567681062, 7628.466007379541, 7631.885521717179, 7702.653380597886, 7734.226577342333, 6861.725530978805, 6889.414399776075, 6934.16789985205, 7002.579845209304, 7045.612491312924, 7084.149902011792, 7140.464465165133, 7180.874788141839, 7257.82674961899, 7268.709251629982, 2007.8494112941296, 2014.6977953306828, 2026.6959956006717, 2077.200277893022, 2127.9148834046773, 832.5129799067493, 856.7643897927995, 885.968991085309, 891.22463456793, 893.8346405914797, 17390.565235869206, 17413.65172696539, 17510.38713645042, 17820.0, 18046.097695115193, 874.711345256064, 874.9825003499894, 876.7808047988003, 880.9036237624754, 886.6320477001972, 9329.207017403596, 9795.963196493349, 9863.112319891245, 9907.504624768877, 9974.152197063186, 393725.0, 394362.0, 401727.0, 401784.0, 403158.0, 81739.0, 82054.58972705099, 82259.5887020573, 82572.17427825765, 84810.0, 1014.1785154025263, 1031.8245898197324, 1057.814882395593, 1061.7186445591924, 1066.5147357952112, 17293.481195564153, 18765.68640195173, 19718.90140549288, 19744.308949187285, 19762.90118549398, 47193.999999998625, 47543.0, 47605.52394476011, 47846.76076619595, 48374.75812620914, 52777.47222527879, 52928.0, 53403.0, 53605.0, 53668.73165634147, 8875.511846848485, 9239.815203695754, 9310.906890931004, 9363.906360936577, 9385.530723463662, 15334.309956052228, 15838.68322633564, 16012.519624411287, 16612.750808737637, 16660.916695416447, 13451.125676830974, 13579.25314107694, 14022.158670479805, 14131.15213087218, 14203.502877399242, 11961.222520536137, 12390.194637348544, 12422.130450868352, 12478.376081195722, 12734.872651273368, 14069.296535173406, 14278.143311401349, 14287.142771433748, 14292.142471451747, 14384.35270412813, 9484.715458536255, 9519.952400237955, 9557.665481708107, 9572.186364159124, 9589.089036541518, 13458.52895148665, 13628.591142265748, 13676.589702308947, 13677.384517696528, 13686.384112714753], "value": 9344.44886580078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.606422009177, 1318.3276528970234, 1329.8005299205117, 1354.1468874609002, 1360.8571100034494, 9949.602015919363, 10128.594856205744, 10419.479026048695, 10469.424181670014, 10493.108085812695, 10337.896621033806, 10520.684379468628, 10538.736531586714, 10543.209259305564, 10569.841452378221, 2036.0735865181343, 2071.1301253473575, 2077.979220207801, 2078.7423608716736, 2080.1991233375184, 1968.9507762305914, 2028.077224862684, 2028.8985550722405, 2036.2669439001947, 2042.5097976485686, 1831.587892724133, 1852.5831687870257, 1852.833245007949, 1858.6189831084596, 1861.8045105263955, 1850.9814901850943, 1853.7868145163343, 1856.4152292028036, 1859.9256029758794, 1863.1243315641696, 1845.4832646858902, 1917.990410047941, 1924.8748831326059, 1958.490792393988, 1968.7145363922293, 10168.237382196365, 10235.79528409435, 10240.641577544824, 10249.897501024969, 10266.7433314167, 5226.0, 5414.512693857571, 5416.9729151353995, 5433.723075077353, 5441.7279136043435, 3087.6603573606885, 3204.0, 3239.7894136881027, 3243.2378391078078, 3244.821534815584, 1012.0840639221443, 1030.07808011829, 1043.4521876015076, 1046.837740150278, 1054.0618849224197, 14529.273536323142, 14538.563843084725, 14714.926425367912, 14732.484363047242, 15178.571428571375, 4734.257252500345, 4751.3348131261655, 4839.782209800567, 4844.467108618049, 4888.120138375127, 11164.553417863195, 11256.606018789304, 11277.54889804415, 11278.661640150809, 11281.774364512663, 5399.271098401666, 5501.257330260443, 5508.476694713996, 5508.807191748269, 5513.117901135799, 4945.530174633404, 5025.522575355335, 5041.445441001487, 5066.290719299301, 5093.567046801063, 3939.290927632996, 3974.642282194616, 3981.7013723970817, 3990.74060186087, 4075.1034772350035, 1146.363768108691, 1150.7180740718577, 1158.3802665573878, 1168.9649310520697, 1169.6198735411026, 685.2633419074515, 704.6582407532343, 708.3660124188925, 720.0243669827413, 727.1637616740791, 5108.3103780989095, 5210.0, 5253.212018197224, 5310.946890531122, 5416.458354164631, 547.9561635069185, 557.4704031170404, 561.5563704673344, 566.9829905102854, 570.3156212544963, 3208.5828842250357, 3230.353929214167, 3340.711612545414, 3464.566929133858, 3787.3182827090836, 11957.34234617087, 12148.69628259283, 12158.696032599255, 12162.635120946386, 13101.803472947913, 11885.88114118865, 12129.272243665408, 12145.392730363623, 12146.392680366123, 12160.452779624939, 6587.538872278895, 7375.668094935633, 7479.887801682979, 7529.0, 7624.885626715603, 5822.505087067647, 6002.879942401215, 6156.6921653918025, 6214.9067763984485, 6328.0824280478155, 10990.010899019127, 11030.22788404804, 11062.39156846349, 11065.944670276596, 11105.0, 11377.2604780689, 11409.258398204422, 11441.427928603704, 11456.484458199568, 11459.942700286778, 7909.564973926259, 8045.195480451908, 8070.0, 8081.515109093473, 8097.716579919675, 9568.856467152858, 9596.760080997752, 9627.326087173831, 9654.56554455037, 9669.758256043655, 7875.960620196863, 7906.644201010853, 7993.560354180576, 8192.180781922, 8401.243888050105, 7706.460547761603, 7850.371970242481, 7903.644336005009, 7978.3218426434405, 7997.360211182975, 6405.231372235362, 6498.220213574401, 6499.415052645285, 6500.70746816385, 6508.381703738138, 4988.451270360185, 5010.0, 5036.320096786887, 5050.873728156826, 5135.589152867687, 4732.47942726293, 4792.472827988849, 4904.632152588499, 4924.655274130777, 4928.0390323886495], "value": 4507.523059716723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.18708441619987, 362.21038136861637, 363.20458196549555, 366.11400411005366, 374.3860069486045, 5457.617966742329, 5539.1968164616155, 5582.832515024551, 5599.664020158793, 5620.831375058745, 5361.169018802092, 5427.158790387486, 5435.510804027636, 5449.155380915964, 5450.073487507133, 4132.628063474287, 4143.627073563379, 4158.438610787535, 4159.70882038256, 4179.582041795819, 4184.518780340254, 4188.97905510472, 4190.329547272437, 4196.223698615766, 4216.198922204771, 4147.419361289422, 4153.6677065834665, 4155.958440415588, 4160.983287116846, 4162.4796900387455, 4148.23257697327, 4156.189543039109, 4158.750474971512, 4160.854370097032, 4176.665866730655, 3646.6353364663587, 3659.432787917877, 3661.41417373219, 3670.137517683342, 3677.797721125337, 5400.78396864125, 5423.701696406696, 5429.809956651498, 5444.972775136139, 5445.156000819879, 4923.113839508887, 4928.531789479994, 4931.408231012266, 4933.7286449245275, 4941.616347422728, 5783.40956237034, 5821.563382746311, 5822.184894114827, 5825.650460972312, 5839.7664093436215, 4092.1201941582704, 4115.8765237042935, 4117.135401565675, 4117.56765539617, 4118.361653943613, 5768.567357448208, 6136.325004249529, 6204.627722336674, 6210.5715685392615, 6215.384000159946, 4141.130362623822, 4167.541570427311, 4191.0, 4191.182719369694, 4195.370694395804, 4222.577742225752, 4225.535191128974, 4225.619694227473, 4244.4932049122735, 4247.405363249148, 4640.141573808856, 4847.491013443609, 4849.69639421272, 4852.272159176081, 4856.41722993236, 5778.104393818965, 5787.2476578045425, 5797.275340582427, 5799.33307669615, 5806.506446952057, 1434.2470203143432, 1439.6688761584894, 1456.3446449097949, 1457.9343929523197, 1459.6861674739982, 938.3853575907655, 973.5424350555228, 977.6578197630772, 981.9607215711435, 986.2307400227834, 4996.400431948189, 5004.499550044967, 5009.7244651544515, 5009.874753131128, 5020.849374518771, 5998.730057147439, 6007.729652165663, 6013.278406591149, 6032.909506357408, 6053.606515576474, 4974.77613507393, 4994.001199760062, 5003.0, 5013.448520662724, 5013.774380152902, 3172.6192856857324, 3173.397054559626, 3185.9044228672715, 3209.4864821628425, 3216.935661286761, 5567.246317410003, 5583.330000399978, 5589.245451863946, 5595.888082238333, 5601.29983752031, 6160.168377269101, 6163.96918015416, 6200.720967556471, 6214.285357183891, 6233.376662333821, 5573.191887176336, 5580.218769372291, 5581.134924086773, 5586.245856809279, 5606.6636001840025, 6009.699515024144, 6030.336662966983, 6042.365551617193, 6051.636901785907, 6068.7269072892705, 5936.46571808522, 5963.165156878127, 5963.821085367446, 5966.224390829338, 5968.313643931004, 5253.894922101613, 5531.419200984, 5549.5837812165055, 5557.694326812064, 5564.108203210928, 4024.7987600620436, 4024.8993775155855, 4028.4964379452567, 4028.9798551007057, 4039.5758445362812, 5971.522278217645, 6010.909836352545, 6020.4280593343565, 6025.337212906665, 6032.276126864805, 5611.775528978795, 5738.942610573841, 5764.135379692912, 5773.6824474654295, 5801.506871915934, 5767.625104368202, 5782.190493330853, 5784.768609255582, 5791.478766910998, 5802.303723553032, 5695.0603150481365, 5721.313442386941, 5734.741936612779, 5751.367349591458, 5755.798547051, 5839.883202336015, 5853.795117170878, 5869.0, 5871.354151043296, 5890.4698577128265, 5619.719014049199, 5690.630109042899, 5708.514776244066, 5718.684702518361, 5743.8564035899435], "value": 4345.214767627842, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.4165338635466, 687.5702685821361, 689.2969171445126, 700.9859802803944, 703.0, 13092.083554151213, 13485.460581576737, 13523.391447384854, 15657.138857362841, 16802.579935501617, 15370.462033828819, 15378.154201518912, 15417.383304667828, 15499.302531386087, 15619.921900390482, 888.1917455115846, 900.9369344145913, 905.3617199874072, 905.642271302835, 906.3610154840821, 888.205056474455, 911.7583840282331, 914.5153068873508, 915.5193523400202, 932.8460803967371, 970.5438443931341, 978.8580655804903, 978.9657361992332, 979.5738853598707, 980.0934135924277, 965.1217392173124, 966.1787480641469, 968.7142293023575, 970.9660161894335, 974.990250097497, 701.7929710735294, 706.6113637499407, 707.7487491940338, 709.2588245283639, 712.6436781609195, 14038.0, 14362.066465679802, 14498.710025799424, 14558.854411455855, 14604.561863144123, 14304.570862874027, 14653.12081275127, 14721.779173312301, 14757.704845903128, 14760.630984225372, 13090.214587124803, 13176.86823131766, 13289.0, 13405.731885362238, 13457.259850708208, 3063.6170478690165, 3070.7543396528226, 3077.753779697619, 3078.5074388097796, 3084.706952839477, 83942.58028709878, 84087.0, 84242.57878710628, 85430.14569854284, 86240.13759862384, 12002.699932501582, 12080.697982550506, 12260.386980650932, 12263.93868030654, 12267.325297108744, 19836.60326793456, 20338.186472540932, 20531.692024619642, 20590.176392944115, 20654.277100301417, 5941.732622032019, 6115.571909966348, 6147.569670123048, 6256.499480041586, 6274.6548939807835, 3100.798448100866, 3165.240342317827, 3192.9361412771614, 3196.6803319667847, 3200.2799370141997, 3508.9122771930397, 3557.0395993081725, 3562.8574857005947, 3563.572371315407, 3575.66031227033, 700.5481464455398, 700.6321681117454, 701.824543864034, 705.4497491956282, 708.2068083746237, 589.0443726826979, 606.266417634667, 607.8510764862637, 623.9875202496015, 628.7327885648581, 9722.9027709722, 10577.048065674126, 10884.945575272232, 11019.228653994303, 11255.155863310121, 604.4952464692032, 610.8045425463808, 620.2773768559578, 635.4947816485904, 643.2955913274957, 4499.55004499554, 4796.856094317176, 4835.734034628129, 4853.272009198648, 4972.955679307386, 86921.56539217263, 87512.0, 87765.56117219373, 88634.0, 89333.0, 77868.0, 78261.0, 78266.21733782589, 78321.0, 78887.60556197182, 61524.692376536936, 63629.0, 64152.358476414636, 67860.64278714398, 71085.0, 9889.406635601887, 10125.848112278174, 10227.94886025565, 10328.638497652546, 10459.0, 27076.1877143686, 27374.17877463679, 27517.449651007268, 27821.02626408066, 28695.282617934718, 33824.830875845466, 34337.0, 34348.31303373868, 34516.65483345235, 34783.82608086943, 13707.177569345871, 13777.448902043807, 14083.929580352033, 14240.0, 14302.068076044177, 15514.456994005155, 15570.532884013497, 16486.917565412095, 16502.42241521541, 16762.748558771873, 14318.427262909783, 14666.926665366605, 14740.778888316469, 14752.704945901236, 14943.701125977203, 13944.651383715489, 14244.359003844645, 14453.277336132942, 14893.106413615218, 15118.0, 13602.863971360555, 13977.790333144807, 14117.576472705836, 14172.858271417153, 15293.388264469297, 10153.79692406133, 10300.484975751033, 10581.418022008864, 10756.623518176826, 10921.399323037309, 11776.175667703179, 12303.93848030754, 12733.681657958625, 12826.55107071248, 12897.551959376508], "value": 7158.958190077045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 110.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 137.0, 176.0, 125.0, 128.0, 134.0, 123.0, 151.0, 127.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 163.0, 167.0, 169.0, 175.0, 164.0, 164.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 76.0, 102.0, 76.0, 76.0, 76.0, 79.0, 96.0, 75.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 83.0, 83.0, 83.0, 99.0, 83.0, 85.0, 103.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 115.0, 115.0, 113.0, 113.0, 113.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 153.0, 151.0, 152.0, 152.0, 151.0, 153.0, 154.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 55.0, 56.0, 58.0, 55.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 56.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 95.0, 87.0, 86.0, 88.0, 90.0, 88.0, 128.0, 86.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 145.0, 134.0, 143.0, 135.0, 137.0, 129.0, 129.0, 130.0, 146.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 195.0, 195.0, 193.0, 196.0, 196.0, 196.0, 207.0, 193.0, 192.0], "value": 195.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 77.0, 73.0, 72.0, 71.0, 77.0, 70.0, 74.0], "value": 73.4, "unit": "score"}]}]} 09:44:15 INFO - Return code: 0 09:44:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:15 INFO - # TBPL SUCCESS # 09:44:15 INFO - Running post-action listener: _resource_record_post_action 09:44:15 INFO - [mozharness: 2017-06-01 16:44:15.525147Z] Finished run-tests step (success) 09:44:15 INFO - Running post-run listener: _resource_record_post_run 09:44:15 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403550208; Read time: 16; Write time: 255160 09:44:15 INFO - TinderboxPrint: CPU usage
12.6% 09:44:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:44:15 INFO - TinderboxPrint: I/O write bytes / time
403,550,208 / 255,160 09:44:15 INFO - TinderboxPrint: CPU idle
8,758.5 (87.4%) 09:44:15 INFO - TinderboxPrint: CPU user
1,216.6 (12.1%) 09:44:15 INFO - TinderboxPrint: Swap in / out
0 / 0 09:44:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84836352; Read time: 0; Write time: 62288 09:44:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:44:15 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305926144; Read time: 16; Write time: 188860 09:44:16 INFO - Running post-run listener: _upload_blobber_files 09:44:16 INFO - Blob upload gear active. 09:44:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:44:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:44:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:44:16 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:17 INFO - (blobuploader) - INFO - Done attempting. 09:44:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:18 INFO - (blobuploader) - INFO - Done attempting. 09:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:24 INFO - (blobuploader) - INFO - Done attempting. 09:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:24 INFO - (blobuploader) - INFO - Done attempting. 09:44:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:24 INFO - Return code: 0 09:44:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e18ee1ccaa167fc67651ffd80d4d86be501a01d4e3ca3bfd43bf327ef177603ff23695d2a4b9be8aebd3f5af8ae1f46142a4cd14b39e899a87efcd8aac17048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5eae74f65caa89367467d593e5d32b5ea794f4f9f3972910ea58bd455dbcf9ad15f120290e965f474a1636f89d0fdddd5ead1e7ce66fad1ca7eaa4aaacdf77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecaf50d461a7cc6cefda06e4c146330b1461e9bbd88ef4e4e77fe749e96c8254064051149727169a6423d46ec375a9887426759dd4f0a9cbac6846d503bea6ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec39282b66f60ac05ba2b997735e35097a3bd6b39916f1da99782b00269434a9fb0e74df788bf4bc06be4b852efce19cb21418eb504f02eaaf7b0b62ad3082f"} 09:44:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:24 INFO - Contents: 09:44:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e18ee1ccaa167fc67651ffd80d4d86be501a01d4e3ca3bfd43bf327ef177603ff23695d2a4b9be8aebd3f5af8ae1f46142a4cd14b39e899a87efcd8aac17048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5eae74f65caa89367467d593e5d32b5ea794f4f9f3972910ea58bd455dbcf9ad15f120290e965f474a1636f89d0fdddd5ead1e7ce66fad1ca7eaa4aaacdf77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecaf50d461a7cc6cefda06e4c146330b1461e9bbd88ef4e4e77fe749e96c8254064051149727169a6423d46ec375a9887426759dd4f0a9cbac6846d503bea6ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec39282b66f60ac05ba2b997735e35097a3bd6b39916f1da99782b00269434a9fb0e74df788bf4bc06be4b852efce19cb21418eb504f02eaaf7b0b62ad3082f"} 09:44:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:24 INFO - Copying logs to upload dir... 09:44:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.320869 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-01 09:44:25.082273) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 09:44:25.091793) ========= 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-1496333385.113082-876753787 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/1e18ee1ccaa167fc67651ffd80d4d86be501a01d4e3ca3bfd43bf327ef177603ff23695d2a4b9be8aebd3f5af8ae1f46142a4cd14b39e899a87efcd8aac17048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5eae74f65caa89367467d593e5d32b5ea794f4f9f3972910ea58bd455dbcf9ad15f120290e965f474a1636f89d0fdddd5ead1e7ce66fad1ca7eaa4aaacdf77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecaf50d461a7cc6cefda06e4c146330b1461e9bbd88ef4e4e77fe749e96c8254064051149727169a6423d46ec375a9887426759dd4f0a9cbac6846d503bea6ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec39282b66f60ac05ba2b997735e35097a3bd6b39916f1da99782b00269434a9fb0e74df788bf4bc06be4b852efce19cb21418eb504f02eaaf7b0b62ad3082f"} build_url:https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/VqFKKkZ5Qv2qKizPxPAhSw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e18ee1ccaa167fc67651ffd80d4d86be501a01d4e3ca3bfd43bf327ef177603ff23695d2a4b9be8aebd3f5af8ae1f46142a4cd14b39e899a87efcd8aac17048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e5eae74f65caa89367467d593e5d32b5ea794f4f9f3972910ea58bd455dbcf9ad15f120290e965f474a1636f89d0fdddd5ead1e7ce66fad1ca7eaa4aaacdf77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ecaf50d461a7cc6cefda06e4c146330b1461e9bbd88ef4e4e77fe749e96c8254064051149727169a6423d46ec375a9887426759dd4f0a9cbac6846d503bea6ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ec39282b66f60ac05ba2b997735e35097a3bd6b39916f1da99782b00269434a9fb0e74df788bf4bc06be4b852efce19cb21418eb504f02eaaf7b0b62ad3082f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 09:44:25.120783) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:44:25.121174) ========= 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-1496333385.113082-876753787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:44:25.199194) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 09:44:25.201562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 09:44:25.201875) ========= ========= Total master_lag: 0.24 =========