builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1496279306.74 results: success (0) revision: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.736680) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.737221) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.737514) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.766046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.766329) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-31 18:08:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2017-05-31 18:08:28 (45.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117418 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.896765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.897387) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017537 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.947133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 18:08:26.947484) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 --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 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 --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=a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-31 18:08:28,182 truncating revision to first 12 chars 2017-05-31 18:08:28,182 Setting DEBUG logging. 2017-05-31 18:08:28,182 attempt 1/10 2017-05-31 18:08:28,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7fb3d9dfa8e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-31 18:08:29,553 unpacking tar archive at: mozilla-central-7fb3d9dfa8e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.698813 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 18:08:28.658536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.658850) ========= script_repo_revision: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.659227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.659504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.668115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2017-05-31 18:08:28.668504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:08:30 INFO - MultiFileLogger online at 20170531 18:08:30 in /builds/slave/test 18:08:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:08:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:08:30 INFO - {'append_to_log': False, 18:08:30 INFO - 'base_work_dir': '/builds/slave/test', 18:08:30 INFO - 'blob_upload_branch': 'Firefox', 18:08:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:08:30 INFO - 'branch': 'Firefox', 18:08:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:08:30 INFO - 'config_files': ('talos/linux_config.py',), 18:08:30 INFO - 'default_actions': ('clobber', 18:08:30 INFO - 'read-buildbot-config', 18:08:30 INFO - 'download-and-extract', 18:08:30 INFO - 'populate-webroot', 18:08:30 INFO - 'create-virtualenv', 18:08:30 INFO - 'install', 18:08:30 INFO - 'setup-mitmproxy', 18:08:30 INFO - 'run-tests'), 18:08:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:08:30 INFO - 'download_minidump_stackwalk': True, 18:08:30 INFO - 'download_symbols': 'ondemand', 18:08:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:08:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:08:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:08:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:08:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:08:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:08:30 INFO - 'gecko_profile': False, 18:08:30 INFO - 'gecko_profile_interval': 0, 18:08:30 INFO - 'installer_path': 'installer.exe', 18:08:30 INFO - 'log_level': 'info', 18:08:30 INFO - 'log_name': 'talos', 18:08:30 INFO - 'log_to_console': True, 18:08:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:08:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:08:30 INFO - 'opt_config_files': (), 18:08:30 INFO - 'pip_index': False, 18:08:30 INFO - 'suite': 'dromaeojs-e10s', 18:08:30 INFO - 'system_bits': '32', 18:08:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:08:30 INFO - 'title': 'talos-linux64-ix-062', 18:08:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:08:30 INFO - 'use_talos_json': True, 18:08:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:08:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:08:30 INFO - 'work_dir': 'build'} 18:08:30 INFO - [mozharness: 2017-06-01 01:08:30.016300Z] Running clobber step. 18:08:30 INFO - Running pre-action listener: _resource_record_pre_action 18:08:30 INFO - Running main action method: clobber 18:08:30 INFO - rmtree: /builds/slave/test/build 18:08:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:08:31 INFO - Running post-action listener: _resource_record_post_action 18:08:31 INFO - [mozharness: 2017-06-01 01:08:31.046554Z] Finished clobber step (success) 18:08:31 INFO - [mozharness: 2017-06-01 01:08:31.046656Z] Running read-buildbot-config step. 18:08:31 INFO - Running pre-action listener: _resource_record_pre_action 18:08:31 INFO - Running main action method: read_buildbot_config 18:08:31 INFO - Using buildbot properties: 18:08:31 INFO - { 18:08:31 INFO - "project": "", 18:08:31 INFO - "product": "firefox", 18:08:31 INFO - "who": "ryanvm@gmail.com", 18:08:31 INFO - "installer_path": "public/build/target.tar.bz2", 18:08:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:08:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:08:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:08:31 INFO - "stage_platform": "linux64-stylosequential", 18:08:31 INFO - "basedir": "/builds/slave/test", 18:08:31 INFO - "buildnumber": 35, 18:08:31 INFO - "platform": "ubuntu64_hw_styloseq", 18:08:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:08:31 INFO - "slavebuilddir": "test", 18:08:31 INFO - "taskId": "SJ-I3S53TQGg43BO17wBGg", 18:08:31 INFO - "branch": "mozilla-central", 18:08:31 INFO - "script_repo_revision": "production", 18:08:31 INFO - "revision": "7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205", 18:08:31 INFO - "slavename": "talos-linux64-ix-062", 18:08:31 INFO - "repo_path": "mozilla-central" 18:08:31 INFO - } 18:08:31 INFO - Finding installer, test and symbols from parent task. 18:08:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJ-I3S53TQGg43BO17wBGg'}, attempt #1 18:08:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SJ-I3S53TQGg43BO17wBGg'}, attempt #1 18:08:31 INFO - Task dependencies: QIDwbIK6QUiOx0mk4t3s6A 18:08:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A'}, attempt #1 18:08:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:08:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/test_packages.json 18:08:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip 18:08:32 INFO - Running post-action listener: _resource_record_post_action 18:08:32 INFO - [mozharness: 2017-06-01 01:08:32.416612Z] Finished read-buildbot-config step (success) 18:08:32 INFO - [mozharness: 2017-06-01 01:08:32.416833Z] Running download-and-extract step. 18:08:32 INFO - Running pre-action listener: _resource_record_pre_action 18:08:32 INFO - Running main action method: download_and_extract 18:08:32 INFO - mkdir: /builds/slave/test/build/tests 18:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:32 INFO - trying https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.test_packages.json 18:08:32 INFO - Downloading https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:08:33 INFO - Downloaded 986 bytes. 18:08:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:08:33 INFO - Using the following test package requirements: 18:08:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:08:33 INFO - u'common': [u'target.common.tests.zip'], 18:08:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:08:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:08:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:08:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:08:33 INFO - u'mozbase': [u'target.common.tests.zip'], 18:08:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:08:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:08:33 INFO - u'web-platform': [u'target.common.tests.zip', 18:08:33 INFO - u'target.web-platform.tests.zip'], 18:08:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:08:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:08:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip 18:08:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:08:33 INFO - Fetch https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip into memory 18:08:37 INFO - Content-Length response header: 63527515 18:08:37 INFO - Bytes received: 63527515 18:08:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:08:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip 18:08:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:08:47 INFO - Fetch https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip into memory 18:08:51 INFO - Content-Length response header: 63527515 18:08:51 INFO - Bytes received: 63527515 18:09:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.talos.tests.zip 18:09:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:09:03 INFO - Fetch https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.talos.tests.zip into memory 18:09:04 INFO - Content-Length response header: 14447425 18:09:04 INFO - Bytes received: 14447425 18:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:04 INFO - trying https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:09:04 INFO - Downloading https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:09:09 INFO - Downloaded 56019989 bytes. 18:09:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:09:09 INFO - mkdir: /builds/slave/test/properties 18:09:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:09 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:09 INFO - Contents: 18:09:09 INFO - build_url:https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:09:09 INFO - Running post-action listener: _resource_record_post_action 18:09:09 INFO - Running post-action listener: set_extra_try_arguments 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.859879Z] Finished download-and-extract step (success) 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.860106Z] Running populate-webroot step. 18:09:09 INFO - Running pre-action listener: _resource_record_pre_action 18:09:09 INFO - Running main action method: populate_webroot 18:09:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:09 INFO - '--tppagecycles', 18:09:09 INFO - '7'], 18:09:09 INFO - 'tests': ['tsvgm']}}, 18:09:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:09:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:09:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['damp', 'tps']}, 18:09:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'tests': ['damp', 'tps']}, 18:09:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['dromaeo_dom']}, 18:09:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:09:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:09:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:09:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other-e10s': {'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:09:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:09:09 INFO - 'bloom_basic_ref']}, 18:09:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 18:09:09 INFO - 'talos_options': ['--mitmproxy', 18:09:09 INFO - 'mitmproxy-recording-1.mp', 18:09:09 INFO - '--firstNonBlankPaint'], 18:09:09 INFO - 'tests': ['Quantum_1']}, 18:09:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['tsvgx', 18:09:09 INFO - 'tsvgr_opacity', 18:09:09 INFO - 'tart', 18:09:09 INFO - 'tscrollx', 18:09:09 INFO - 'cart', 18:09:09 INFO - 'tsvg_static']}, 18:09:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:09:09 INFO - 'tsvgr_opacity', 18:09:09 INFO - 'tart', 18:09:09 INFO - 'tscrollx', 18:09:09 INFO - 'cart', 18:09:09 INFO - 'tsvg_static']}, 18:09:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['tp5o']}, 18:09:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:09:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s', 18:09:09 INFO - '--xperf_path', 18:09:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:09 INFO - 'tests': ['tp5n']}, 18:09:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--xperf_path', 18:09:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:09 INFO - 'tests': ['tp5n']}}, 18:09:09 INFO - 'talos.zip': {'path': '', 18:09:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:09 INFO - Running post-action listener: _resource_record_post_action 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.880364Z] Finished populate-webroot step (success) 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.880458Z] Running create-virtualenv step. 18:09:09 INFO - Running pre-action listener: _resource_record_pre_action 18:09:09 INFO - Running main action method: create_virtualenv 18:09:09 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:09 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 18:09:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:09 INFO - Using real prefix '/usr' 18:09:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:10 INFO - Installing distribute.............................................................................................................................................................................................done. 18:09:12 INFO - Installing pip.................done. 18:09:12 INFO - Return code: 0 18:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:09:12 INFO - Reading from file tmpfile_stdout 18:09:12 INFO - Output received: 18:09:12 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) 18:09:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:09:12 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')]} 18:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:12 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')]} 18:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:12 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:12 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 18:09:12 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 18:09:12 INFO - Using env: {'DISPLAY': ':0', 18:09:12 INFO - 'HOME': '/home/cltbld', 18:09:12 INFO - 'LANG': 'en_US.UTF-8', 18:09:12 INFO - 'LANGUAGE': 'en_US:en', 18:09:12 INFO - 'LOGNAME': 'cltbld', 18:09:12 INFO - 'MAIL': '/var/mail/cltbld', 18:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:12 INFO - 'MOZ_NO_REMOTE': '1', 18:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:12 INFO - 'NO_EM_RESTART': '1', 18:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:12 INFO - 'PWD': '/builds/slave/test', 18:09:12 INFO - 'SHELL': '/bin/bash', 18:09:12 INFO - 'SHLVL': '1', 18:09:12 INFO - 'TERM': 'linux', 18:09:12 INFO - 'TMOUT': '86400', 18:09:12 INFO - 'USER': 'cltbld', 18:09:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:12 INFO - '_': '/tools/buildbot/bin/python'} 18:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:12 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 18:09:12 INFO - Cleaning up... 18:09:12 INFO - Return code: 0 18:09:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:09:12 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')]} 18:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:12 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')]} 18:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:12 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:12 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 18:09:12 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 18:09:12 INFO - Using env: {'DISPLAY': ':0', 18:09:12 INFO - 'HOME': '/home/cltbld', 18:09:12 INFO - 'LANG': 'en_US.UTF-8', 18:09:12 INFO - 'LANGUAGE': 'en_US:en', 18:09:12 INFO - 'LOGNAME': 'cltbld', 18:09:12 INFO - 'MAIL': '/var/mail/cltbld', 18:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:12 INFO - 'MOZ_NO_REMOTE': '1', 18:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:12 INFO - 'NO_EM_RESTART': '1', 18:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:12 INFO - 'PWD': '/builds/slave/test', 18:09:12 INFO - 'SHELL': '/bin/bash', 18:09:12 INFO - 'SHLVL': '1', 18:09:12 INFO - 'TERM': 'linux', 18:09:12 INFO - 'TMOUT': '86400', 18:09:12 INFO - 'USER': 'cltbld', 18:09:12 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:12 INFO - '_': '/tools/buildbot/bin/python'} 18:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:13 INFO - Downloading/unpacking psutil>=3.1.1 18:09:13 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 18:09:13 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 18:09:13 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 18:09:13 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 18:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:09:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:14 INFO - Installing collected packages: psutil 18:09:14 INFO - Running setup.py install for psutil 18:09:14 INFO - building 'psutil._psutil_linux' extension 18:09:14 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 18:09:14 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 18:09:14 INFO - building 'psutil._psutil_posix' extension 18:09:14 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 18:09:14 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 18:09:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:14 INFO - Successfully installed psutil 18:09:14 INFO - Cleaning up... 18:09:14 INFO - Return code: 0 18:09:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09: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')]} 18:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:14 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:14 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 18:09:14 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 18:09:14 INFO - Using env: {'DISPLAY': ':0', 18:09:14 INFO - 'HOME': '/home/cltbld', 18:09:14 INFO - 'LANG': 'en_US.UTF-8', 18:09:14 INFO - 'LANGUAGE': 'en_US:en', 18:09:14 INFO - 'LOGNAME': 'cltbld', 18:09:14 INFO - 'MAIL': '/var/mail/cltbld', 18:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:14 INFO - 'MOZ_NO_REMOTE': '1', 18:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:14 INFO - 'NO_EM_RESTART': '1', 18:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:14 INFO - 'PWD': '/builds/slave/test', 18:09:14 INFO - 'SHELL': '/bin/bash', 18:09:14 INFO - 'SHLVL': '1', 18:09:14 INFO - 'TERM': 'linux', 18:09:14 INFO - 'TMOUT': '86400', 18:09:14 INFO - 'USER': 'cltbld', 18:09:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:14 INFO - '_': '/tools/buildbot/bin/python'} 18:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:09: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 18:09: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 18:09: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 18:09: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 18:09:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:09:16 INFO - Installing collected packages: mozsystemmonitor 18:09:16 INFO - Running setup.py install for mozsystemmonitor 18:09:16 INFO - Successfully installed mozsystemmonitor 18:09:16 INFO - Cleaning up... 18:09:16 INFO - Return code: 0 18:09:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:16 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:16 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 18:09:16 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 18:09:16 INFO - Using env: {'DISPLAY': ':0', 18:09:16 INFO - 'HOME': '/home/cltbld', 18:09:16 INFO - 'LANG': 'en_US.UTF-8', 18:09:16 INFO - 'LANGUAGE': 'en_US:en', 18:09:16 INFO - 'LOGNAME': 'cltbld', 18:09:16 INFO - 'MAIL': '/var/mail/cltbld', 18:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:16 INFO - 'MOZ_NO_REMOTE': '1', 18:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:16 INFO - 'NO_EM_RESTART': '1', 18:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:16 INFO - 'PWD': '/builds/slave/test', 18:09:16 INFO - 'SHELL': '/bin/bash', 18:09:16 INFO - 'SHLVL': '1', 18:09:16 INFO - 'TERM': 'linux', 18:09:16 INFO - 'TMOUT': '86400', 18:09:16 INFO - 'USER': 'cltbld', 18:09:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:16 INFO - '_': '/tools/buildbot/bin/python'} 18:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:16 INFO - Downloading/unpacking jsonschema==2.5.1 18:09:16 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 18:09:16 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 18:09:16 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 18:09:16 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 18:09:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:09:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:09: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 18:09: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 18:09: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 18:09: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 18:09:17 INFO - Downloading functools32-3.2.3-2.tar.gz 18:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:09:17 INFO - warning: no files found matching '*.txt' 18:09:17 INFO - no previously-included directories found matching 'build' 18:09:17 INFO - no previously-included directories found matching 'dist' 18:09:17 INFO - no previously-included directories found matching '.git*' 18:09:17 INFO - Installing collected packages: jsonschema, functools32 18:09:17 INFO - Running setup.py install for functools32 18:09:17 INFO - warning: no files found matching '*.txt' 18:09:17 INFO - no previously-included directories found matching 'build' 18:09:17 INFO - no previously-included directories found matching 'dist' 18:09:17 INFO - no previously-included directories found matching '.git*' 18:09:18 INFO - Successfully installed jsonschema functools32 18:09:18 INFO - Cleaning up... 18:09:18 INFO - Return code: 0 18:09:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09: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')]} 18:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09: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', '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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:09: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 functools32==3.2.3-2 18:09:18 INFO - Using env: {'DISPLAY': ':0', 18:09:18 INFO - 'HOME': '/home/cltbld', 18:09:18 INFO - 'LANG': 'en_US.UTF-8', 18:09:18 INFO - 'LANGUAGE': 'en_US:en', 18:09:18 INFO - 'LOGNAME': 'cltbld', 18:09:18 INFO - 'MAIL': '/var/mail/cltbld', 18:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:18 INFO - 'MOZ_NO_REMOTE': '1', 18:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:18 INFO - 'NO_EM_RESTART': '1', 18:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:18 INFO - 'PWD': '/builds/slave/test', 18:09:18 INFO - 'SHELL': '/bin/bash', 18:09:18 INFO - 'SHLVL': '1', 18:09:18 INFO - 'TERM': 'linux', 18:09:18 INFO - 'TMOUT': '86400', 18:09:18 INFO - 'USER': 'cltbld', 18:09:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:18 INFO - '_': '/tools/buildbot/bin/python'} 18:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:09:18 INFO - Cleaning up... 18:09:18 INFO - Return code: 0 18:09:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09: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')]} 18:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09: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', '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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:09: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 blobuploader==1.2.4 18:09:18 INFO - Using env: {'DISPLAY': ':0', 18:09:18 INFO - 'HOME': '/home/cltbld', 18:09:18 INFO - 'LANG': 'en_US.UTF-8', 18:09:18 INFO - 'LANGUAGE': 'en_US:en', 18:09:18 INFO - 'LOGNAME': 'cltbld', 18:09:18 INFO - 'MAIL': '/var/mail/cltbld', 18:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:18 INFO - 'MOZ_NO_REMOTE': '1', 18:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:18 INFO - 'NO_EM_RESTART': '1', 18:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:18 INFO - 'PWD': '/builds/slave/test', 18:09:18 INFO - 'SHELL': '/bin/bash', 18:09:18 INFO - 'SHLVL': '1', 18:09:18 INFO - 'TERM': 'linux', 18:09:18 INFO - 'TMOUT': '86400', 18:09:18 INFO - 'USER': 'cltbld', 18:09:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:18 INFO - '_': '/tools/buildbot/bin/python'} 18:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:18 INFO - Downloading/unpacking blobuploader==1.2.4 18:09:18 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 18:09:18 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 18:09:18 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 18:09:18 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 18:09:19 INFO - Downloading blobuploader-1.2.4.tar.gz 18:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:09:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:09:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:20 INFO - Downloading docopt-0.6.1.tar.gz 18:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:09:20 INFO - Installing collected packages: blobuploader, requests, docopt 18:09:20 INFO - Running setup.py install for blobuploader 18:09:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:09:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:09:20 INFO - Running setup.py install for requests 18:09:20 INFO - Running setup.py install for docopt 18:09:20 INFO - Successfully installed blobuploader requests docopt 18:09:20 INFO - Cleaning up... 18:09:20 INFO - Return code: 0 18:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:20 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:20 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 18:09:20 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 18:09:20 INFO - Using env: {'DISPLAY': ':0', 18:09:20 INFO - 'HOME': '/home/cltbld', 18:09:20 INFO - 'LANG': 'en_US.UTF-8', 18:09:20 INFO - 'LANGUAGE': 'en_US:en', 18:09:20 INFO - 'LOGNAME': 'cltbld', 18:09:20 INFO - 'MAIL': '/var/mail/cltbld', 18:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:20 INFO - 'MOZ_NO_REMOTE': '1', 18:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:20 INFO - 'NO_EM_RESTART': '1', 18:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:20 INFO - 'PWD': '/builds/slave/test', 18:09:20 INFO - 'SHELL': '/bin/bash', 18:09:20 INFO - 'SHLVL': '1', 18:09:20 INFO - 'TERM': 'linux', 18:09:20 INFO - 'TMOUT': '86400', 18:09:20 INFO - 'USER': 'cltbld', 18:09:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:20 INFO - '_': '/tools/buildbot/bin/python'} 18:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:20 INFO - Running setup.py (path:/tmp/pip-LIms1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:21 INFO - Running setup.py (path:/tmp/pip-HAIYn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:21 INFO - Running setup.py (path:/tmp/pip-HN7IVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:21 INFO - Running setup.py (path:/tmp/pip-l6i1Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:21 INFO - Running setup.py (path:/tmp/pip-EF_ZSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:21 INFO - Running setup.py (path:/tmp/pip-9vonyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:21 INFO - Running setup.py (path:/tmp/pip-rwFZcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:21 INFO - Running setup.py (path:/tmp/pip-BOx2mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:21 INFO - Running setup.py (path:/tmp/pip-U4RdVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:21 INFO - Running setup.py (path:/tmp/pip-97hvpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:21 INFO - Running setup.py (path:/tmp/pip-nem89v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:21 INFO - Running setup.py (path:/tmp/pip-2qkYmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:21 INFO - Running setup.py (path:/tmp/pip-JWaZxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:21 INFO - Running setup.py (path:/tmp/pip-OP4mVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:22 INFO - Running setup.py (path:/tmp/pip-oRY8Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:22 INFO - Running setup.py (path:/tmp/pip-kBO4D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:22 INFO - Running setup.py (path:/tmp/pip-53jpD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:09:22 INFO - Running setup.py install for manifestparser 18:09:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozcrash 18:09:22 INFO - Running setup.py install for mozdebug 18:09:22 INFO - Running setup.py install for mozdevice 18:09:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozfile 18:09:22 INFO - Running setup.py install for mozhttpd 18:09:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozinfo 18:09:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozInstall 18:09:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Running setup.py install for mozleak 18:09:23 INFO - Running setup.py install for mozlog 18:09:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Running setup.py install for moznetwork 18:09:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Running setup.py install for mozprocess 18:09:23 INFO - Running setup.py install for mozprofile 18:09:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Running setup.py install for mozrunner 18:09:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Running setup.py install for mozscreenshot 18:09:23 INFO - Running setup.py install for moztest 18:09:23 INFO - Running setup.py install for mozversion 18:09:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:09:23 INFO - Cleaning up... 18:09:24 INFO - Return code: 0 18:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:24 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')]} 18:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:24 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')]} 18:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:24 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:24 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 18:09:24 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 18:09:24 INFO - Using env: {'DISPLAY': ':0', 18:09:24 INFO - 'HOME': '/home/cltbld', 18:09:24 INFO - 'LANG': 'en_US.UTF-8', 18:09:24 INFO - 'LANGUAGE': 'en_US:en', 18:09:24 INFO - 'LOGNAME': 'cltbld', 18:09:24 INFO - 'MAIL': '/var/mail/cltbld', 18:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:24 INFO - 'MOZ_NO_REMOTE': '1', 18:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:24 INFO - 'NO_EM_RESTART': '1', 18:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:24 INFO - 'PWD': '/builds/slave/test', 18:09:24 INFO - 'SHELL': '/bin/bash', 18:09:24 INFO - 'SHLVL': '1', 18:09:24 INFO - 'TERM': 'linux', 18:09:24 INFO - 'TMOUT': '86400', 18:09:24 INFO - 'USER': 'cltbld', 18:09:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:24 INFO - '_': '/tools/buildbot/bin/python'} 18:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:24 INFO - Running setup.py (path:/tmp/pip-6Ogs_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:24 INFO - Running setup.py (path:/tmp/pip-OFBava-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:24 INFO - Running setup.py (path:/tmp/pip-8hUl3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:24 INFO - Running setup.py (path:/tmp/pip-i11ptI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:24 INFO - Running setup.py (path:/tmp/pip-Df4280-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:24 INFO - Running setup.py (path:/tmp/pip-RRgNII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:24 INFO - Running setup.py (path:/tmp/pip-4HIOJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:24 INFO - Running setup.py (path:/tmp/pip-ijFUKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:24 INFO - Running setup.py (path:/tmp/pip-MvoWX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:24 INFO - Running setup.py (path:/tmp/pip-TLsFo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:24 INFO - Running setup.py (path:/tmp/pip-xgyymy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:25 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)) 18:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:25 INFO - Running setup.py (path:/tmp/pip-des8Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:25 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)) 18:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:25 INFO - Running setup.py (path:/tmp/pip-d_mdIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:25 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)) 18:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:25 INFO - Running setup.py (path:/tmp/pip-HpDr7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:25 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)) 18:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:25 INFO - Running setup.py (path:/tmp/pip-Y7QeK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:25 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)) 18:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:25 INFO - Running setup.py (path:/tmp/pip-TqBEbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:25 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)) 18:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:25 INFO - Running setup.py (path:/tmp/pip-Xt1qUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:25 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)) 18:09:25 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)) 18:09:25 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)) 18:09:25 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)) 18:09:25 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)) 18:09:25 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)) 18:09:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:09:25 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 18:09:25 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 18:09:25 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 18:09:25 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 18:09:26 INFO - Downloading blessings-1.6.tar.gz 18:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:09:26 INFO - Installing collected packages: blessings 18:09:26 INFO - Running setup.py install for blessings 18:09:26 INFO - Successfully installed blessings 18:09:26 INFO - Cleaning up... 18:09:26 INFO - Return code: 0 18:09:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:27 INFO - Reading from file tmpfile_stdout 18:09:27 INFO - Current package versions: 18:09:27 INFO - argparse == 1.2.1 18:09:27 INFO - blessings == 1.6 18:09:27 INFO - blobuploader == 1.2.4 18:09:27 INFO - docopt == 0.6.1 18:09:27 INFO - functools32 == 3.2.3-2 18:09:27 INFO - jsonschema == 2.5.1 18:09:27 INFO - manifestparser == 1.1 18:09:27 INFO - mozInstall == 1.12 18:09:27 INFO - mozcrash == 1.0 18:09:27 INFO - mozdebug == 0.1 18:09:27 INFO - mozdevice == 0.51 18:09:27 INFO - mozfile == 1.2 18:09:27 INFO - mozhttpd == 0.7 18:09:27 INFO - mozinfo == 0.9 18:09:27 INFO - mozleak == 0.1 18:09:27 INFO - mozlog == 3.4 18:09:27 INFO - moznetwork == 0.27 18:09:27 INFO - mozprocess == 0.25 18:09:27 INFO - mozprofile == 0.28 18:09:27 INFO - mozrunner == 6.13 18:09:27 INFO - mozscreenshot == 0.1 18:09:27 INFO - mozsystemmonitor == 0.3 18:09:27 INFO - moztest == 0.8 18:09:27 INFO - mozversion == 1.4 18:09:27 INFO - psutil == 3.1.1 18:09:27 INFO - requests == 1.2.3 18:09:27 INFO - wsgiref == 0.1.2 18:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:27 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:27 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 18:09:27 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 18:09:27 INFO - Using env: {'DISPLAY': ':0', 18:09:27 INFO - 'HOME': '/home/cltbld', 18:09:27 INFO - 'LANG': 'en_US.UTF-8', 18:09:27 INFO - 'LANGUAGE': 'en_US:en', 18:09:27 INFO - 'LOGNAME': 'cltbld', 18:09:27 INFO - 'MAIL': '/var/mail/cltbld', 18:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:27 INFO - 'MOZ_NO_REMOTE': '1', 18:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:27 INFO - 'NO_EM_RESTART': '1', 18:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:27 INFO - 'PWD': '/builds/slave/test', 18:09:27 INFO - 'SHELL': '/bin/bash', 18:09:27 INFO - 'SHLVL': '1', 18:09:27 INFO - 'TERM': 'linux', 18:09:27 INFO - 'TMOUT': '86400', 18:09:27 INFO - 'USER': 'cltbld', 18:09:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:27 INFO - '_': '/tools/buildbot/bin/python'} 18:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:09:27 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 18:09:27 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 18:09:27 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 18:09:27 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 18:09:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:09:28 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)) 18:09:28 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)) 18:09:28 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)) 18:09:28 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)) 18:09:28 INFO - Installing collected packages: marionette-driver 18:09:28 INFO - Running setup.py install for marionette-driver 18:09:28 INFO - Successfully installed marionette-driver 18:09:28 INFO - Cleaning up... 18:09:28 INFO - Return code: 0 18:09:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09: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')]} 18:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:28 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 0xb2e3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd08a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeacdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', '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 18:09:28 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 18:09:28 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 18:09:28 INFO - Using env: {'DISPLAY': ':0', 18:09:28 INFO - 'HOME': '/home/cltbld', 18:09:28 INFO - 'LANG': 'en_US.UTF-8', 18:09:28 INFO - 'LANGUAGE': 'en_US:en', 18:09:28 INFO - 'LOGNAME': 'cltbld', 18:09:28 INFO - 'MAIL': '/var/mail/cltbld', 18:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:28 INFO - 'MOZ_NO_REMOTE': '1', 18:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:28 INFO - 'NO_EM_RESTART': '1', 18:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:28 INFO - 'PWD': '/builds/slave/test', 18:09:28 INFO - 'SHELL': '/bin/bash', 18:09:28 INFO - 'SHLVL': '1', 18:09:28 INFO - 'TERM': 'linux', 18:09:28 INFO - 'TMOUT': '86400', 18:09:28 INFO - 'USER': 'cltbld', 18:09:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:28 INFO - '_': '/tools/buildbot/bin/python'} 18:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:09:28 INFO - Cleaning up... 18:09:28 INFO - Return code: 0 18:09:28 INFO - Running post-action listener: _resource_record_post_action 18:09:28 INFO - Running post-action listener: _start_resource_monitoring 18:09:28 INFO - Starting resource monitoring. 18:09:28 INFO - [mozharness: 2017-06-01 01:09:28.831618Z] Finished create-virtualenv step (success) 18:09:28 INFO - [mozharness: 2017-06-01 01:09:28.832201Z] Running install step. 18:09:28 INFO - Running pre-action listener: _resource_record_pre_action 18:09:28 INFO - Running main action method: install 18:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:29 INFO - Reading from file tmpfile_stdout 18:09:29 INFO - Detecting whether we're running mozinstall >=1.0... 18:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:09:29 INFO - Reading from file tmpfile_stdout 18:09:29 INFO - Output received: 18:09:29 INFO - Usage: mozinstall [options] installer 18:09:29 INFO - Options: 18:09:29 INFO - -h, --help show this help message and exit 18:09:29 INFO - -d DEST, --destination=DEST 18:09:29 INFO - Directory to install application into. [default: 18:09:29 INFO - "/builds/slave/test"] 18:09:29 INFO - --app=APP Application being installed. [default: firefox] 18:09:29 INFO - mkdir: /builds/slave/test/build/application 18:09:29 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'] 18:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:09:45 INFO - Reading from file tmpfile_stdout 18:09:45 INFO - Output received: 18:09:45 INFO - /builds/slave/test/build/application/firefox/firefox 18:09:45 INFO - Running post-action listener: _resource_record_post_action 18:09:45 INFO - [mozharness: 2017-06-01 01:09:45.258600Z] Finished install step (success) 18:09:45 INFO - [mozharness: 2017-06-01 01:09:45.258879Z] Running setup-mitmproxy step. 18:09:45 INFO - Running pre-action listener: _resource_record_pre_action 18:09:45 INFO - Running main action method: setup_mitmproxy 18:09:45 INFO - Skipping: mitmproxy is not required 18:09:45 INFO - Running post-action listener: _resource_record_post_action 18:09:45 INFO - [mozharness: 2017-06-01 01:09:45.260014Z] Finished setup-mitmproxy step (success) 18:09:45 INFO - [mozharness: 2017-06-01 01:09:45.260239Z] Running run-tests step. 18:09:45 INFO - Running pre-action listener: _resource_record_pre_action 18:09:45 INFO - Running main action method: run_tests 18:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:09:45 INFO - Python 2.7.3 18:09:45 INFO - Return code: 0 18:09:45 INFO - grabbing minidump binary from tooltool 18:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:45 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 0xea9840>, '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 0xeaa740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaabd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:09:45 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 18:09:45 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 18:09:45 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 18:09:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:09:45 INFO - Return code: 0 18:09:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:09:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:09:45 INFO - ENV: RUST_BACKTRACE is now 1 18:09:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:09:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 18:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 18:09:45 INFO - Using env: {'DISPLAY': ':0', 18:09:45 INFO - 'HOME': '/home/cltbld', 18:09:45 INFO - 'LANG': 'en_US.UTF-8', 18:09:45 INFO - 'LANGUAGE': 'en_US:en', 18:09:45 INFO - 'LOGNAME': 'cltbld', 18:09:45 INFO - 'MAIL': '/var/mail/cltbld', 18:09:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:09:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:45 INFO - 'MOZ_NO_REMOTE': '1', 18:09:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:45 INFO - 'NO_EM_RESTART': '1', 18:09:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:45 INFO - 'PWD': '/builds/slave/test', 18:09:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:09:45 INFO - 'RUST_BACKTRACE': '1', 18:09:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:09:45 INFO - 'SHELL': '/bin/bash', 18:09:45 INFO - 'SHLVL': '1', 18:09:45 INFO - 'TERM': 'linux', 18:09:45 INFO - 'TMOUT': '86400', 18:09:45 INFO - 'USER': 'cltbld', 18:09:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926', 18:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:45 INFO - '_': '/tools/buildbot/bin/python'} 18:09:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 18:09:45 INFO - mozversion application_buildid: 20170601002546 18:09:45 INFO - mozversion application_changeset: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 18:09:45 INFO - mozversion application_display_name: Nightly 18:09:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:09:45 INFO - mozversion application_name: Firefox 18:09:45 INFO - mozversion application_remotingname: firefox 18:09:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:09:45 INFO - mozversion application_vendor: Mozilla 18:09:45 INFO - mozversion application_version: 55.0a1 18:09:45 INFO - mozversion platform_buildid: 20170601002546 18:09:45 INFO - mozversion platform_changeset: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 18:09:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:09:45 INFO - mozversion platform_version: 55.0a1 18:09:45 INFO - using testdate: 1496279385 18:09:45 INFO - actual date: 1496279385 18:09:45 INFO - starting webserver on 'localhost:50917' 18:09:45 INFO - SUITE-START | Running 2 tests 18:09:45 INFO - TEST-START | dromaeo_css 18:09:45 INFO - operating with platform_type : linux_ 18:09:45 INFO - Initialising browser for dromaeo_css test... 18:09:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50917/getInfo.html -profile /tmp/tmpaVfMGM/profile 18:09:45 INFO - TEST-INFO | started process 8244 (/builds/slave/test/build/application/firefox/firefox http://localhost:50917/getInfo.html) 18:10:20 INFO - TEST-INFO | 8244: killed by SIGTERM 18:10:20 INFO - Browser initialized. 18:10:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:10:20 INFO - TEST-INFO | started process 8474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaVfMGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:32 INFO - PID 8474 | RSS: Main: 188805120 18:10:32 INFO - PID 8474 | 18:13:36 INFO - PID 8474 | Cycle 1(1): loaded http://localhost:50917/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50917/tests/dromaeo/cssquery-ext.html) 18:13:38 INFO - PID 8474 | RSS: Main: 182628352 18:13:38 INFO - PID 8474 | 18:16:40 INFO - PID 8474 | Cycle 1(1): loaded http://localhost:50917/tests/dromaeo/cssquery-ext.html (next: http://localhost:50917/tests/dromaeo/cssquery-jquery.html) 18:16:41 INFO - PID 8474 | RSS: Main: 188620800 18:16:41 INFO - PID 8474 | 18:19:42 INFO - PID 8474 | Cycle 1(1): loaded http://localhost:50917/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50917/tests/dromaeo/cssquery-mootools.html) 18:19:43 INFO - PID 8474 | RSS: Main: 185585664 18:19:43 INFO - PID 8474 | 18:22:45 INFO - PID 8474 | Cycle 1(1): loaded http://localhost:50917/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50917/tests/dromaeo/cssquery-prototype.html) 18:22:46 INFO - PID 8474 | RSS: Main: 189112320 18:22:46 INFO - PID 8474 | 18:25:49 INFO - PID 8474 | Cycle 1(1): loaded http://localhost:50917/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50917/tests/dromaeo/cssquery-yui.html) 18:25:49 INFO - PID 8474 | RSS: Main: 188252160 18:25:49 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | Cycle 1(1): loaded http://localhost:50917/tests/dromaeo/cssquery-yui.html (next: http://localhost:50917/tests/dromaeo/cssquery-dojo.html) 18:28:51 INFO - PID 8474 | RSS: Main: 185270272 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | __start_tp_report 18:28:51 INFO - PID 8474 | _x_x_mozilla_page_load 18:28:51 INFO - PID 8474 | _x_x_mozilla_page_load_details 18:28:51 INFO - PID 8474 | |i|pagename|runs| 18:28:51 INFO - PID 8474 | |0;dojo.html;2708.2823051891246;2721.6733991920973;2726.127639155471;2762.751352378287;2764.2674691206835;5199.532042116209;5211.983663185681;5236.581073514119;5252.133397989337;5280.313559237298;5198.350206224222;5216.087184742664;5280.5247527722495;5284.260203571503;5330.733463326837;4683.7892294846815;4684.46128695201;4709.576138147566;4710.599599034086;4731.90536189276;4702;4749.643776716743;4783.402074740658;4785.497522760113;4838;4697.553732395417;4723.07899959508;4730.290456431529;4733.053389322149;4781;4688.132695451352;4709.9764501177615;4727.527247275245;4741.952580474185;4760.785764640599;4652.55800698933;4657.5575320344515;4718.127146477913;4729.834455794031;4749.620030397595;5152.227165925104;5247.055530004598;5271.341082364705;5284.81503147388;5285.075111855448;5511.311086114236;5638.872225554865;5672.262605861253;5673.546116310686;5702.714864256812;5682.772689092431;5801.970990145022;5811.302643682785;5828.446297601721;5838.591298609099;5287.894242115136;5299.2316114164005;5309.628326017219;5358.223057656696;5367.75845086972;5707.286589176353;5881.911771323434;5896.292444906639;5900.085486749561;5906.438888305604;5470.398256191816;5528.115501519818;5644.3508996465935;5654.46282603152;5697.173909783141;5649.435056494318;5710;5728.79949201776;5740.56945729072;5741.8564535886935;5516.972415137899;5578.386377498472;5669.348024977098;5682.602217844711;5710.857228569319;5632.633878797865;5653.462921022497;5664;5711.286089238845;5717.313922329347;4786.1863483207935;4791.5687588117235;4794.832180873653;4808.447028591687;4832.106060378841;4088.9591104089172;4095.5904409559403;4102.548719640837;4109.198706252252;4149.937750933738;4713.6464765142755;4714.6464015199;4772.284157376422;4787.114383838932;4796.472388037313;5713.914291285634;5730;5744.856378590569;5770.942290577124;5801.477866991907;4768.833090841873;4776;4776.689515181502;4784.832530861403;4807.326974223612;4980.90038199234;5058.797648094109;5061.468545802712;5076.517730815566;5080.898382032338;5270.578353731769;5346.893062138658;5347.251384806208;5365.195220716923;5377.166539186276;5556.861078472909;5631.521320687787;5714.257146570919;5740.885182296247;5758.827235182951;5220.1647736362;5278.498542638443;5280.683159010318;5290.25936368901;5350.545203657577;5575.052241118939;5622.88754224905;5652.463016013472;5675.687837168995;5689.260396148474;5704.971475142598;5731.627444216113;5753.884922301447;5764.769409223752;5766.682832444256;5500.80747173847;5515.310586176728;5544.667319960815;5582.8325150245555;5592.328920529562;5556.777728890961;5564.10974244119;5574.637648552831;5576.247206627054;5585.469380408855;5356.384015838228;5392.757325920422;5417.079096553674;5434.701091439851;5488.4785945335125;5465.836024919259;5485.094959331665;5517.44825517445;5529.723513824373;5627.634203776742;5462.6449280798215;5470.015397228378;5470.507654311131;5495.917561236664;5499.642523235977 18:28:51 INFO - PID 8474 | |1;ext.html;630.9526785491089;670.4937771982154;696.5368030259876;1201.633501781956;1259.3451405269254;33103;33918.49122263168;33992;34053.97838064859;34122;32864.34271314572;32995.50506742395;33170.17074573131;33212.50181247277;33230.8338458308;6219.346968568303;6417.903731444032;6441.389652586853;6597.37324954131;6688.598684078971;6590.472762179014;6685.264620891722;6688.230853451842;6706.1558071530235;6742.089817874597;6698.296678848724;6707;6723.529352945296;6737;6746.224184218804;6668.9666551667415;6682.83292917676;6683.5655682380975;6698.363655452724;6698.39714425704;6682.465402767767;6707.262201157869;6722.462203023795;6723.831904202385;6737.19153701554;31347.05958821239;31353.529697054564;31499.070204554962;31500.227451098122;31929;3053.175642576492;3054.0990407829745;3087.289923317627;3089.4439000979814;3106.8601912913746;24529.386765331008;24543.14099006526;24579.13973010936;24592;24648.260552183463;3032.863521141554;3078.6921307869034;3087.5831762711973;3128.7966282191815;3139.8901038463773;142624;143694;143965;154776;157211.2139439307;38827.417588735625;38828.6117138825;39004;39062.804685976385;39158.412623810094;40930;41045.79477102655;41050.973725657095;41104;43839;12531.624051278477;12693.428795704216;12693.873061269269;12707.682307942376;12877.549285774952;10080.243981701402;10178.13485853696;10207.489625518843;10263.384196948207;10302.484875756183;12608.495660173674;12629.747405051847;12673.93663031679;12713.110082294335;12753.107282490322;5528.530074943595;5533.253010843565;5534.833954981357;5570.916436253459;5608.523275521627;855.9957200213959;887.9112088791069;909.4770506958525;913.1827014821697;941.0824446164935;19893.701594476093;20525;20784.48038799042;21462.356129316144;21468.78531214668;979.8089372572423;987.3138168972495;989.871316728835;992.8560358748085;996.9800603988025;11141.331520108819;11173.83239251412;11198.160137989684;11266.293304257259;11384.146189035855;175939;176452;176768;177416;178316.10841945707;40042.399364009565;40451;40668.389974150414;40684.389734154014;40712;1224.7366816134574;1236.6722818453118;1246.9750604987848;1254.078252484405;1259.2633309514038;19538.90230548838;19881.502962426053;19963.500912477306;20612.175512979313;20952.47618809542;28913.132606021853;36652;37210.25579488449;37293.4405983905;37388.6261137396;161413;162429;163316;163519.5600549931;163566;29222.707772922;30032.3993520124;30109.247268818453;30462.238444039078;30529.08412747621;35058.123546911535;35932.820335898155;36121.458178127876;36192.63807361998;36952.445713313784;26595.867020664773;27179.184624461297;27399.726002739717;27609.447811043265;28515.144545663665;26562.203133906012;26825.463490730468;27121.72878271192;27459.03893363723;28723.856380717963;30302.242443938198;30564;30665.693343067178;30723;30770.076897693107;25645.743542564334;26175.1944494429;26446.206613801616;27152.321191970357;27275.181744547695;19634.312799051964;21698.65566879501;22157.55684886261;22186.112555498246;22194.88902555477 18:28:51 INFO - PID 8474 | |2;jquery.html;421.570860246837;426.4583978347497;434.42221844946226;439.3190554640308;445.3031006474869;17940.641187176265;18736.25054997802;18745.437636870898;19143.521411964673;19983.900080499578;19584.412467625993;19961.10175042123;20026.29907953222;20035.799642003574;20084.29704960327;5563.248961390201;5665.093585026397;5674.404187560309;5686.3744988051285;5694.6867922264255;5540.584456165783;5609.382967873531;5616.943830561703;5627.352854421732;5636.7463464144;5291.1798671206025;5581;5587.357453892813;5608.074667679828;5626.915596266039;5427.701476418795;5490.670559766427;5494.36814766301;5501.229827824108;5523.4200408956885;4961.156603377434;4968.056069346812;4985.202367621199;4997.225430058346;5000.274960130797;23442.296731098093;23811.404714882094;23850.642240366407;23854.284371468882;23861.642075368884;1618.8381161883835;1633.5834362237554;1634.6730653869154;1638.361039194715;1640.7866977292995;15558.144302063381;15605.921970390076;16033.118178500177;16212;16278.83721162785;2064.783197764228;2070.8136267735977;2112;2122.936311910645;2124.2034237161065;94488;95015.04984950132;97881;99175.50412247964;99342.5032874831;11200.21598488098;11244.49399777012;11261.605843795427;11497;11508.53965841357;15960.680786384208;16005.439809606607;16020.235244717482;16094.517164485083;16151.273192706356;7302.160251571137;7513.2862378074;7600.239976002466;7705.267999540035;7746.41901857363;6929.861402771916;6941.409980151642;6974.26770189133;7049.436045116378;7055.118110236221;7392.408607311402;7441.813954651068;7496.512726672749;7593.658285377061;7644.885326720104;2053.743282089739;2060.1759296281607;2062.7318448601586;2112.3134981131193;2212.6570381590877;824.7690646618956;851.2764150472049;876.9649214031494;899.1727610598265;902.3773596218588;17415.129243537773;17490.737638935425;17916.372926947493;17919.73120403195;17940;867.1068799136899;878.0780180810124;897.1028971028971;897.8428774964485;908.6274627402734;9322.347435679438;9837.458939758239;9838.557264923096;9956.103950644332;10037.498125093862;352863;381087;382012;382609;390580;87798.56100719456;91519.54240228757;91770;92523;92631.53684231536;972.7762614598682;991.1575161112996;1095.1950316517352;1113.8830422805652;1130.4065365682918;18208.271669133086;18279.725804112684;18599.81400185981;18992;19154.904225478782;45086.549134508234;45488.77255613701;45539.772301138284;45989.54010459853;46030.309545357515;56283;56341.71829140828;56409.43590564206;56544.71727641336;57191.142132868874;9588.328816982745;9672.129508344282;9717.611295548098;9731.318807683394;9861.408315501092;13981.300934953415;14043.719125617226;14193.432262709375;14211.431542738175;14231;13081.542146024844;13155.276459794803;13161.868381316064;13260.071794974645;13293.268870211845;12279.631611051684;12356.691082723004;12542;12588.559400421307;12684.175528590613;12105.69735756578;12354.567590134302;12459.439325230205;12462.376881156088;12528.185667931555;8817.426867253607;9267.67563135287;9514.762130946781;9587.089226523749;9633.08485693858;13412.865871341162;13576.93211533936;13720.90232781395;13776.24230667323;13839.861601383856 18:28:51 INFO - PID 8474 | |3;mootools.html;1262.2174251963781;1312.0422091872927;1322.570164696474;1324.0863803975255;1336.9532066377678;10486.213533984954;10915.672529824098;10921.453927303623;10977.231593788418;11263.718407039829;10842.620508282213;10986.945065274662;10992.890071099286;11027.669169924895;11124;2116.111233282021;2147.473868902121;2170.077716970289;2172.9891350543303;2177.68423578581;2085.113826623679;2138.7112739780086;2145.549434618732;2149.441145302225;2150.591387636352;2062.247279742898;2094.424033390822;2096.5178009057927;2102.0645812613393;2108.7996640319143;2054.969175462369;2061.4537147655883;2070.896455177243;2071.30611245233;2072.3990042887544;1858.944231673052;1926.4702206893076;1958.265650381107;2003.5692326149801;2119.830413566911;10660.147188225;10788;10788.73028174294;10795.190360722898;10850.186236032328;5515.696636684981;5743.282089738783;5762.250907382056;5767.625104368202;5780.942190578083;3152.5271209318557;3269.5095735639607;3293.110860067792;3308.024132880782;3313.1385839681857;933.4446004627235;951.6669165791986;965.6089283840056;966.9564869580815;970.1608108985677;15792;15933.601659958478;15991.440299589574;15993.800464965057;16023.679526409407;4767.499412561631;4787.473377928425;4810.975945120322;4911.607071434277;5012.298278241049;11822.467988940518;11910.285382877055;11946;11952.581659642045;11976.401179941142;5534.806281780199;5675.602707810413;5677.489025987681;5679.4320567943705;5680.40355762639;5150.304708864331;5201.739913004335;5229.738513074331;5234.502722241381;5242.842714718565;3976.383660532622;4045.977011494253;4060.39094135882;4130.359794231899;4154.273002224599;1210.1105687319814;1214.2046959241711;1221.712897469094;1243.160866415166;1243.2664727810636;624.1480379282337;705.4532737128766;707.8230442389403;721.7113154738147;728.7194430144433;5909.704514774244;5964.075568286922;5964.761409543657;5982.282126144803;6057.515398768088;826.9131741167212;857.3998201259019;861.3195575495414;863.313665635821;883.6907082521195;3510.613832478425;3553.697935675445;3621.2395396966403;3697.0757310672334;3975.4434379186937;13322.866771332356;13847;13856.653583660287;13918.234497102756;13926.025178237629;13566.525171618947;13707.657308567366;13740;13794.862051379558;13855.722885542233;7471.402287816962;7663.770086897402;7782.143964163937;7793.493422927491;7852.411069169721;6049;6120.479759220516;6130.111133885473;6136.32500424944;6189.84525386869;12512.687182820502;12746.10777245584;12806.103572749818;12889.355532223164;13065.412056457671;12810.743785124432;13137.277449739973;13242.53651122206;13435;13466.865331346562;8903.287736980896;9239.72280831576;9247.075292470969;9256.25949923991;9267.165955064076;10017.799644007226;10116.443595602312;10151.84772228432;10159.949200253952;10174.898251017692;8009.159038300894;8392.706255281037;8416.579171041545;8455.492670439793;8496.320294376312;8272.37957153204;8290.170982901662;8310.87533686983;8418.87371689413;8474.576271186294;7140.6786694599905;7263.382612477999;7287.927120728937;7308.598027108347;7311.647345241147;4985.351904252424;5008.373953255843;5013.548780609763;5193.298904647824;5254.3169387979315;4872.196087645641;4872.269159626085;4934.555889969776;4964.8758781030765;5021.874453138701 18:28:51 INFO - PID 8474 | |4;prototype.html;359.96040435552084;379.2017802525683;382.2164562646575;384.39841647821174;389.6473691309364;5380.596455265852;5552.806146678463;5602.957338395446;5607.775688972436;5610.410906854782;5356.866078348034;5411.269478620385;5411.648242864211;5419.485148910857;5456.454354564542;4152.252594532983;4184.309588917825;4204.306289462235;4210.179015092058;4214.4099826024385;4214.136102099063;4215.747055176699;4217.734679596124;4219.620234178923;4224.112936283384;4174.686898482611;4178.749275043507;4181.916361672765;4182.184474027566;4184.686148538856;4172.207280616673;4178.22702799983;4181.9508440864065;4182.581741825824;4183.330667093281;3693.5013773140818;3718.995871114811;3723.6462536059303;3725.9008592465016;3732.720045996561;5370;5382.596305277119;5386.9900992077355;5404.270423492818;5415.10650742627;4933.55597996182;4940.308356830046;4945.060438516671;4952.281919121707;4956.628252881048;5752.712364381764;5767.711614419304;5775.191473193756;5787.13193021046;5810.82567522975;4122;4154.459920210384;4166.83332666693;4174.645155161815;4185.602367775056;5861.325947516048;5863.237779088691;5970.791022314198;6065.575409721321;6184.474319682788;4156.8129434175535;4194.958050419456;4206.768627725504;4214.620684138442;4216.24107660624;4245.299525578307;4254.936175957363;4259.424977628042;4280.400743895857;4280.807363668642;4693.624510039189;4838.491958344393;4842.806287748521;4855;4856.465788763304;5759.337676167211;5778.27771528559;5780.653160810365;5789.3921138279875;5811.360750317462;1464.736347457468;1469.5077149154938;1470.786735923285;1474.3586539855198;1481.3185934470048;985.3693636072919;992.1318846009741;1014.3356101753363;1020.0819262663514;1028.1209565821264;4965.90068198634;4968.677035992649;4979.779953911315;4982.352294201731;5027.472115427828;5999.100134979788;6004.919114559334;6030.7889223876955;6038.792241551707;6039.1545183674325;4943.555080042742;4972.303877457159;4991.7004979700605;4993.650444468925;5003.724795136302;3155.7002084802366;3171.2230503526785;3178.396104740092;3188.4739018062223;3196.2488815128427;5526.50261476469;5538.501534861801;5586.776528938878;5587.580931430159;5622.606417550732;6116.938830611637;6134.386561343919;6150.661713605795;6199.783007594712;6223.564350495421;5527.364353099365;5550.224887556141;5564.304461942257;5570.832875013756;5572.523281330369;5984.251968503937;5990.31111422192;6021.217241758543;6028.57799953999;6029;5926.762929482772;5939.970300148471;5971.253593300838;5972.848870035284;5980.9401905980385;5211.879445919146;5335.786568537215;5510.338759348904;5592.888142237214;5600.887982240414;4160.3343465046655;4203.015858740328;4214.1571685662375;4234.703570750018;4256.38282449037;5978.790742323998;6017.247844019497;6043.244594425697;6057.363976782551;6062.393760623902;5568.1091025435735;5757.568182386254;5787.9710601448405;5811.1573821794755;5825.242718446575;5691.686957217227;5758.3090029196765;5795.33353664334;5795.33353664334;5841.94158058414;5644.8024319148635;5652.823662889735;5660.235868157746;5690.601657883908;5691.658500489983;5892.705364731832;5900.321463031806;5901.989985107541;5930.970345148246;5935.5548333875995;5697.914531281951;5698.743556540048;5715.342735585461;5724.542036637143;5734.741936612946 18:28:51 INFO - PID 8474 | |5;yui.html;679.5820570349237;692.217793892901;750.8836130399786;756.5649751392949;788.9053313602367;12622.116451848362;13680.247586382746;13703.451861925523;13732.862671373283;14811.851881481181;16540;16648.1675916204;16701.164941752926;16777.580560485992;16899.070551119683;838.5765188579774;860.5095095795399;864.2783275964578;864.4899509289518;864.5504337744369;894.5974311559792;900.2303030908577;913.8126684029792;914.4696076275744;916.9908300917006;934.985975210369;941.0448394879203;943.528235882059;945.1540870920522;945.3382632157483;934.56075644447;938.6855403439856;940.9435433873955;941.7080704981478;942.575840871607;684.8869936460478;687.7661595057655;688.0779755128102;689.9896501552481;691.4779341597113;13769.31153442334;13882.583522494342;13886.652833679138;13889.652758681013;13931.512397066053;14933.253337333199;15241.466548670855;15359.539213823604;15451.304691288806;15517.922410387988;12661.746765064647;12729.363531823465;13214.603561893158;13303.467861285537;13428.060035797498;2960.3339248669095;2987.6414830220297;2989.0733872499377;2991.1923780579123;2996.056242283674;83009;84114.317713646;85069.57465212696;86230.99999999937;86713;13087.476500940045;13214.669633259246;13271.402786874614;13470.595882123553;13486.662833429244;23523.882380587987;24252;24341.513169736507;24349.756502435102;24362.512749744907;6120.540959428061;6218.22272215973;6272.090546870678;6294.181756371642;6352.428281454691;2880.438314528647;2979.657339405953;3025.0924722583136;3062.1732132324146;3075.5386691996378;3600.027992442026;3661.853525858989;3674.063113905937;3684.521012268388;3737.9252414951548;718.468333433266;720.2365492577884;739.6153999920011;743.1750756660103;743.9590822504814;548.5200449606594;598.6049207523014;608.60744819592;622.8256088295285;632.0929466215995;9688.515574221401;10203.183745300357;10358.741031474123;10442.164626829835;10903.127749779998;589.8672798620362;599.349705569462;606.5390303369383;608.5466327585976;622.7664625765339;4765.642576806684;4902.117618828645;4954.47977962316;5063.088644044107;5084.211947148198;85413;86354.56822715847;86385;86540;90951.54524227469;74401.6279918597;75710;75732.62133689407;76828.61585692035;77034;65561.6721916397;66876.66561667257;66910.66544667343;67081.66459167673;69012.654936725;8373.790655233424;8614.698485552975;8635.309175265838;8636.395452318277;8876.911230887608;28907;28953.13140605785;29147.708522914498;29228.853855730584;29945.700542995164;37798.244035118594;37944;39005;39412.40881386839;40057;12656.810147847606;12798.232106073665;12995.675108122372;13004.479820807062;13015.869841301466;14431.278436078364;14450.421983120557;14571.41714331415;14599.270036498345;14812.333444995216;13704.725905481635;13734.381952812348;14296.499622513162;15133.016353936959;15329.923350383177;13546;13716.588502344946;13818.86181138216;15865.444709435576;16219.107949062443;14365.640858978191;14634.853651463349;15329.6167595811;15361.078335299917;15536.300866461263;10464.162866970471;10471.790564188826;10541.57833686644;10664.826869044555;11437.656870293904;9958.850617240892;10815.513301901276;11007.944960275147;11292.830607541058;11443.542258309575 18:28:51 INFO - PID 8474 | __end_tp_report 18:28:51 INFO - PID 8474 | __start_cc_report 18:28:51 INFO - PID 8474 | _x_x_mozilla_cycle_collect,393 18:28:51 INFO - PID 8474 | __end_cc_report 18:28:51 INFO - PID 8474 | __startTimestamp1496280531832__endTimestamp 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | ------- Summary: start ------- 18:28:51 INFO - PID 8474 | Number of tests: 6 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | [#0] dojo.html Cycles:165 Average:5207.42 Median:5358.22 stddev:614.19 (11.5%) stddev-sans-first:583.94 18:28:51 INFO - PID 8474 | Values: 2708.3 2721.7 2726.1 2762.8 2764.3 5199.5 5212.0 5236.6 5252.1 5280.3 5198.4 5216.1 5280.5 5284.3 5330.7 4683.8 4684.5 4709.6 4710.6 4731.9 4702.0 4749.6 4783.4 4785.5 4838.0 4697.6 4723.1 4730.3 4733.1 4781.0 4688.1 4710.0 4727.5 4742.0 4760.8 4652.6 4657.6 4718.1 4729.8 4749.6 5152.2 5247.1 5271.3 5284.8 5285.1 5511.3 5638.9 5672.3 5673.5 5702.7 5682.8 5802.0 5811.3 5828.4 5838.6 5287.9 5299.2 5309.6 5358.2 5367.8 5707.3 5881.9 5896.3 5900.1 5906.4 5470.4 5528.1 5644.4 5654.5 5697.2 5649.4 5710.0 5728.8 5740.6 5741.9 5517.0 5578.4 5669.3 5682.6 5710.9 5632.6 5653.5 5664.0 5711.3 5717.3 4786.2 4791.6 4794.8 4808.4 4832.1 4089.0 4095.6 4102.5 4109.2 4149.9 4713.6 4714.6 4772.3 4787.1 4796.5 5713.9 5730.0 5744.9 5770.9 5801.5 4768.8 4776.0 4776.7 4784.8 4807.3 4980.9 5058.8 5061.5 5076.5 5080.9 5270.6 5346.9 5347.3 5365.2 5377.2 5556.9 5631.5 5714.3 5740.9 5758.8 5220.2 5278.5 5280.7 5290.3 5350.5 5575.1 5622.9 5652.5 5675.7 5689.3 5705.0 5731.6 5753.9 5764.8 5766.7 5500.8 5515.3 5544.7 5582.8 5592.3 5556.8 5564.1 5574.6 5576.2 5585.5 5356.4 5392.8 5417.1 5434.7 5488.5 5465.8 5485.1 5517.4 5529.7 5627.6 5462.6 5470.0 5470.5 5495.9 5499.6 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | [#1] ext.html Cycles:180 Average:30677.65 Median:16924.38 stddev:42124.10 (248.9%) stddev-sans-first:42181.85 18:28:51 INFO - PID 8474 | Values: 631.0 670.5 696.5 1201.6 1259.3 33103.0 33918.5 33992.0 34054.0 34122.0 32864.3 32995.5 33170.2 33212.5 33230.8 6219.3 6417.9 6441.4 6597.4 6688.6 6590.5 6685.3 6688.2 6706.2 6742.1 6698.3 6707.0 6723.5 6737.0 6746.2 6669.0 6682.8 6683.6 6698.4 6698.4 6682.5 6707.3 6722.5 6723.8 6737.2 31347.1 31353.5 31499.1 31500.2 31929.0 3053.2 3054.1 3087.3 3089.4 3106.9 24529.4 24543.1 24579.1 24592.0 24648.3 3032.9 3078.7 3087.6 3128.8 3139.9 142624.0 143694.0 143965.0 154776.0 157211.2 38827.4 38828.6 39004.0 39062.8 39158.4 40930.0 41045.8 41051.0 41104.0 43839.0 12531.6 12693.4 12693.9 12707.7 12877.5 10080.2 10178.1 10207.5 10263.4 10302.5 12608.5 12629.7 12673.9 12713.1 12753.1 5528.5 5533.3 5534.8 5570.9 5608.5 856.0 887.9 909.5 913.2 941.1 19893.7 20525.0 20784.5 21462.4 21468.8 979.8 987.3 989.9 992.9 997.0 11141.3 11173.8 11198.2 11266.3 11384.1 175939.0 176452.0 176768.0 177416.0 178316.1 40042.4 40451.0 40668.4 40684.4 40712.0 1224.7 1236.7 1247.0 1254.1 1259.3 19538.9 19881.5 19963.5 20612.2 20952.5 28913.1 36652.0 37210.3 37293.4 37388.6 161413.0 162429.0 163316.0 163519.6 163566.0 29222.7 30032.4 30109.2 30462.2 30529.1 35058.1 35932.8 36121.5 36192.6 36952.4 26595.9 27179.2 27399.7 27609.4 28515.1 26562.2 26825.5 27121.7 27459.0 28723.9 30302.2 30564.0 30665.7 30723.0 30770.1 25645.7 26175.2 26446.2 27152.3 27275.2 19634.3 21698.7 22157.6 22186.1 22194.9 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | [#2] jquery.html Cycles:180 Average:26775.98 Median:430.44 stddev:63480.99 (14747.9%) stddev-sans-first:63628.23 18:28:51 INFO - PID 8474 | Values: 421.6 426.5 434.4 439.3 445.3 17940.6 18736.3 18745.4 19143.5 19983.9 19584.4 19961.1 20026.3 20035.8 20084.3 5563.2 5665.1 5674.4 5686.4 5694.7 5540.6 5609.4 5616.9 5627.4 5636.7 5291.2 5581.0 5587.4 5608.1 5626.9 5427.7 5490.7 5494.4 5501.2 5523.4 4961.2 4968.1 4985.2 4997.2 5000.3 23442.3 23811.4 23850.6 23854.3 23861.6 1618.8 1633.6 1634.7 1638.4 1640.8 15558.1 15605.9 16033.1 16212.0 16278.8 2064.8 2070.8 2112.0 2122.9 2124.2 94488.0 95015.0 97881.0 99175.5 99342.5 11200.2 11244.5 11261.6 11497.0 11508.5 15960.7 16005.4 16020.2 16094.5 16151.3 7302.2 7513.3 7600.2 7705.3 7746.4 6929.9 6941.4 6974.3 7049.4 7055.1 7392.4 7441.8 7496.5 7593.7 7644.9 2053.7 2060.2 2062.7 2112.3 2212.7 824.8 851.3 877.0 899.2 902.4 17415.1 17490.7 17916.4 17919.7 17940.0 867.1 878.1 897.1 897.8 908.6 9322.3 9837.5 9838.6 9956.1 10037.5 352863.0 381087.0 382012.0 382609.0 390580.0 87798.6 91519.5 91770.0 92523.0 92631.5 972.8 991.2 1095.2 1113.9 1130.4 18208.3 18279.7 18599.8 18992.0 19154.9 45086.5 45488.8 45539.8 45989.5 46030.3 56283.0 56341.7 56409.4 56544.7 57191.1 9588.3 9672.1 9717.6 9731.3 9861.4 13981.3 14043.7 14193.4 14211.4 14231.0 13081.5 13155.3 13161.9 13260.1 13293.3 12279.6 12356.7 12542.0 12588.6 12684.2 12105.7 12354.6 12459.4 12462.4 12528.2 8817.4 9267.7 9514.8 9587.1 9633.1 13412.9 13576.9 13720.9 13776.2 13839.9 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | [#3] mootools.html Cycles:180 Average:6531.03 Median:3532.16 stddev:4357.19 (123.4%) stddev-sans-first:4351.43 18:28:51 INFO - PID 8474 | Values: 1262.2 1312.0 1322.6 1324.1 1337.0 10486.2 10915.7 10921.5 10977.2 11263.7 10842.6 10986.9 10992.9 11027.7 11124.0 2116.1 2147.5 2170.1 2173.0 2177.7 2085.1 2138.7 2145.5 2149.4 2150.6 2062.2 2094.4 2096.5 2102.1 2108.8 2055.0 2061.5 2070.9 2071.3 2072.4 1858.9 1926.5 1958.3 2003.6 2119.8 10660.1 10788.0 10788.7 10795.2 10850.2 5515.7 5743.3 5762.3 5767.6 5780.9 3152.5 3269.5 3293.1 3308.0 3313.1 933.4 951.7 965.6 967.0 970.2 15792.0 15933.6 15991.4 15993.8 16023.7 4767.5 4787.5 4811.0 4911.6 5012.3 11822.5 11910.3 11946.0 11952.6 11976.4 5534.8 5675.6 5677.5 5679.4 5680.4 5150.3 5201.7 5229.7 5234.5 5242.8 3976.4 4046.0 4060.4 4130.4 4154.3 1210.1 1214.2 1221.7 1243.2 1243.3 624.1 705.5 707.8 721.7 728.7 5909.7 5964.1 5964.8 5982.3 6057.5 826.9 857.4 861.3 863.3 883.7 3510.6 3553.7 3621.2 3697.1 3975.4 13322.9 13847.0 13856.7 13918.2 13926.0 13566.5 13707.7 13740.0 13794.9 13855.7 7471.4 7663.8 7782.1 7793.5 7852.4 6049.0 6120.5 6130.1 6136.3 6189.8 12512.7 12746.1 12806.1 12889.4 13065.4 12810.7 13137.3 13242.5 13435.0 13466.9 8903.3 9239.7 9247.1 9256.3 9267.2 10017.8 10116.4 10151.8 10159.9 10174.9 8009.2 8392.7 8416.6 8455.5 8496.3 8272.4 8290.2 8310.9 8418.9 8474.6 7140.7 7263.4 7287.9 7308.6 7311.6 4985.4 5008.4 5013.5 5193.3 5254.3 4872.2 4872.3 4934.6 4964.9 5021.9 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | [#4] prototype.html Cycles:180 Average:4794.10 Median:5407.77 stddev:1402.53 (25.9%) stddev-sans-first:1366.41 18:28:51 INFO - PID 8474 | Values: 360.0 379.2 382.2 384.4 389.6 5380.6 5552.8 5603.0 5607.8 5610.4 5356.9 5411.3 5411.6 5419.5 5456.5 4152.3 4184.3 4204.3 4210.2 4214.4 4214.1 4215.7 4217.7 4219.6 4224.1 4174.7 4178.7 4181.9 4182.2 4184.7 4172.2 4178.2 4182.0 4182.6 4183.3 3693.5 3719.0 3723.6 3725.9 3732.7 5370.0 5382.6 5387.0 5404.3 5415.1 4933.6 4940.3 4945.1 4952.3 4956.6 5752.7 5767.7 5775.2 5787.1 5810.8 4122.0 4154.5 4166.8 4174.6 4185.6 5861.3 5863.2 5970.8 6065.6 6184.5 4156.8 4195.0 4206.8 4214.6 4216.2 4245.3 4254.9 4259.4 4280.4 4280.8 4693.6 4838.5 4842.8 4855.0 4856.5 5759.3 5778.3 5780.7 5789.4 5811.4 1464.7 1469.5 1470.8 1474.4 1481.3 985.4 992.1 1014.3 1020.1 1028.1 4965.9 4968.7 4979.8 4982.4 5027.5 5999.1 6004.9 6030.8 6038.8 6039.2 4943.6 4972.3 4991.7 4993.7 5003.7 3155.7 3171.2 3178.4 3188.5 3196.2 5526.5 5538.5 5586.8 5587.6 5622.6 6116.9 6134.4 6150.7 6199.8 6223.6 5527.4 5550.2 5564.3 5570.8 5572.5 5984.3 5990.3 6021.2 6028.6 6029.0 5926.8 5940.0 5971.3 5972.8 5980.9 5211.9 5335.8 5510.3 5592.9 5600.9 4160.3 4203.0 4214.2 4234.7 4256.4 5978.8 6017.2 6043.2 6057.4 6062.4 5568.1 5757.6 5788.0 5811.2 5825.2 5691.7 5758.3 5795.3 5795.3 5841.9 5644.8 5652.8 5660.2 5690.6 5691.7 5892.7 5900.3 5902.0 5931.0 5935.6 5697.9 5698.7 5715.3 5724.5 5734.7 18:28:51 INFO - PID 8474 | 18:28:51 INFO - PID 8474 | [#5] yui.html Cycles:180 Average:17595.30 Median:3679.29 stddev:23450.83 (637.4%) stddev-sans-first:23482.21 18:28:51 INFO - PID 8474 | Values: 679.6 692.2 750.9 756.6 788.9 12622.1 13680.2 13703.5 13732.9 14811.9 16540.0 16648.2 16701.2 16777.6 16899.1 838.6 860.5 864.3 864.5 864.6 894.6 900.2 913.8 914.5 917.0 935.0 941.0 943.5 945.2 945.3 934.6 938.7 940.9 941.7 942.6 684.9 687.8 688.1 690.0 691.5 13769.3 13882.6 13886.7 13889.7 13931.5 14933.3 15241.5 15359.5 15451.3 15517.9 12661.7 12729.4 13214.6 13303.5 13428.1 2960.3 2987.6 2989.1 2991.2 2996.1 83009.0 84114.3 85069.6 86231.0 86713.0 13087.5 13214.7 13271.4 13470.6 13486.7 23523.9 24252.0 24341.5 24349.8 24362.5 6120.5 6218.2 6272.1 6294.2 6352.4 2880.4 2979.7 3025.1 3062.2 3075.5 3600.0 3661.9 3674.1 3684.5 3737.9 718.5 720.2 739.6 743.2 744.0 548.5 598.6 608.6 622.8 632.1 9688.5 10203.2 10358.7 10442.2 10903.1 589.9 599.3 606.5 608.5 622.8 4765.6 4902.1 4954.5 5063.1 5084.2 85413.0 86354.6 86385.0 86540.0 90951.5 74401.6 75710.0 75732.6 76828.6 77034.0 65561.7 66876.7 66910.7 67081.7 69012.7 8373.8 8614.7 8635.3 8636.4 8876.9 28907.0 28953.1 29147.7 29228.9 29945.7 37798.2 37944.0 39005.0 39412.4 40057.0 12656.8 12798.2 12995.7 13004.5 13015.9 14431.3 14450.4 14571.4 14599.3 14812.3 13704.7 13734.4 14296.5 15133.0 15329.9 13546.0 13716.6 13818.9 15865.4 16219.1 14365.6 14634.9 15329.6 15361.1 15536.3 10464.2 10471.8 10541.6 10664.8 11437.7 9958.9 10815.5 11007.9 11292.8 11443.5 18:28:51 INFO - PID 8474 | -------- Summary: end -------- 18:28:51 INFO - PID 8474 | 18:28:52 INFO - TEST-INFO | 8474: exit 0 18:28:52 INFO - TEST-OK | dromaeo_css | took 1147180ms 18:28:52 INFO - TEST-START | kraken 18:28:52 INFO - operating with platform_type : linux_ 18:28:52 INFO - Initialising browser for kraken test... 18:28:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50917/getInfo.html -profile /tmp/tmpin1BkK/profile 18:28:52 INFO - TEST-INFO | started process 8900 (/builds/slave/test/build/application/firefox/firefox http://localhost:50917/getInfo.html) 18:29:27 INFO - TEST-INFO | 8900: killed by SIGTERM 18:29:27 INFO - Browser initialized. 18:29:27 INFO - Running cycle 1/1 for kraken test... 18:29:27 INFO - TEST-INFO | started process 9129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpin1BkK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:39 INFO - PID 9129 | RSS: Main: 188493824 18:29:39 INFO - PID 9129 | 18:29:42 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50917/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:43 INFO - PID 9129 | RSS: Main: 191533056 18:29:43 INFO - PID 9129 | 18:29:45 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50917/tests/kraken/driver.html?testName=audio-dft) 18:29:46 INFO - PID 9129 | RSS: Main: 190771200 18:29:46 INFO - PID 9129 | 18:29:49 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50917/tests/kraken/driver.html?testName=audio-fft) 18:29:50 INFO - PID 9129 | RSS: Main: 185868288 18:29:50 INFO - PID 9129 | 18:29:52 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50917/tests/kraken/driver.html?testName=audio-oscillator) 18:29:52 INFO - PID 9129 | RSS: Main: 186253312 18:29:52 INFO - PID 9129 | 18:29:55 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50917/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:29:55 INFO - PID 9129 | RSS: Main: 186531840 18:29:55 INFO - PID 9129 | 18:29:58 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50917/tests/kraken/driver.html?testName=imaging-darkroom) 18:29:59 INFO - PID 9129 | RSS: Main: 190308352 18:29:59 INFO - PID 9129 | 18:30:03 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50917/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:03 INFO - PID 9129 | RSS: Main: 186482688 18:30:03 INFO - PID 9129 | 18:30:06 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50917/tests/kraken/driver.html?testName=json-parse-financial) 18:30:07 INFO - PID 9129 | RSS: Main: 186953728 18:30:07 INFO - PID 9129 | 18:30:08 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50917/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:09 INFO - PID 9129 | RSS: Main: 187199488 18:30:09 INFO - PID 9129 | 18:30:11 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:12 INFO - PID 9129 | RSS: Main: 186978304 18:30:12 INFO - PID 9129 | 18:30:14 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:15 INFO - PID 9129 | RSS: Main: 187523072 18:30:15 INFO - PID 9129 | 18:30:17 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:18 INFO - PID 9129 | RSS: Main: 187904000 18:30:18 INFO - PID 9129 | 18:30:21 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:22 INFO - PID 9129 | RSS: Main: 187817984 18:30:22 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | Cycle 1(1): loaded http://localhost:50917/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50917/tests/kraken/driver.html?testName=ai-astar) 18:30:24 INFO - PID 9129 | RSS: Main: 189251584 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | __start_tp_report 18:30:24 INFO - PID 9129 | _x_x_mozilla_page_load 18:30:24 INFO - PID 9129 | _x_x_mozilla_page_load_details 18:30:24 INFO - PID 9129 | |i|pagename|runs| 18:30:24 INFO - PID 9129 | |0;ai-astar;107;112;112;111;116;115;115;116;114;116 18:30:24 INFO - PID 9129 | |1;audio-beat-detection;149;124;123;174;128;129;124;123;146;125 18:30:24 INFO - PID 9129 | |2;audio-dft;163;166;166;167;171;172;168;164;166;165 18:30:24 INFO - PID 9129 | |3;audio-fft;75;75;78;109;76;75;76;76;106;75 18:30:24 INFO - PID 9129 | |4;audio-oscillator;87;84;112;84;84;83;98;84;83;110 18:30:24 INFO - PID 9129 | |5;imaging-gaussian-blur;114;116;115;115;115;114;114;114;116;115 18:30:24 INFO - PID 9129 | |6;imaging-darkroom;153;160;151;149;150;152;151;151;155;155 18:30:24 INFO - PID 9129 | |7;imaging-desaturate;95;96;95;94;95;96;95;96;96;96 18:30:24 INFO - PID 9129 | |8;json-parse-financial;56;55;55;56;58;57;57;58;58;57 18:30:24 INFO - PID 9129 | |9;json-stringify-tinderbox;57;57;56;57;58;57;57;56;57;57 18:30:24 INFO - PID 9129 | |10;stanford-crypto-aes;88;88;87;87;87;89;88;90;121;88 18:30:24 INFO - PID 9129 | |11;stanford-crypto-ccm;134;133;132;134;139;139;143;138;145;152 18:30:24 INFO - PID 9129 | |12;stanford-crypto-pbkdf2;191;201;203;186;201;198;190;203;205;202 18:30:24 INFO - PID 9129 | |13;stanford-crypto-sha256-iterative;77;77;75;73;72;73;74;77;76;75 18:30:24 INFO - PID 9129 | __end_tp_report 18:30:24 INFO - PID 9129 | __start_cc_report 18:30:24 INFO - PID 9129 | _x_x_mozilla_cycle_collect,1018 18:30:24 INFO - PID 9129 | __end_cc_report 18:30:24 INFO - PID 9129 | __startTimestamp1496280624395__endTimestamp 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | ------- Summary: start ------- 18:30:24 INFO - PID 9129 | Number of tests: 14 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:2.91 (2.5%) stddev-sans-first:1.96 18:30:24 INFO - PID 9129 | Values: 107.0 112.0 112.0 111.0 116.0 115.0 115.0 116.0 114.0 116.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:128.50 stddev:16.83 (13.1%) stddev-sans-first:17.02 18:30:24 INFO - PID 9129 | Values: 149.0 124.0 123.0 174.0 128.0 129.0 124.0 123.0 146.0 125.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#2] audio-dft Cycles:10 Average:166.80 Median:166.50 stddev:2.86 (1.7%) stddev-sans-first:2.68 18:30:24 INFO - PID 9129 | Values: 163.0 166.0 166.0 167.0 171.0 172.0 168.0 164.0 166.0 165.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:13.44 (17.8%) stddev-sans-first:14.00 18:30:24 INFO - PID 9129 | Values: 75.0 75.0 78.0 109.0 76.0 75.0 76.0 76.0 106.0 75.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:11.50 (13.7%) stddev-sans-first:12.11 18:30:24 INFO - PID 9129 | Values: 87.0 84.0 112.0 84.0 84.0 83.0 98.0 84.0 83.0 110.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 18:30:24 INFO - PID 9129 | Values: 114.0 116.0 115.0 115.0 115.0 114.0 114.0 114.0 116.0 115.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#6] imaging-darkroom Cycles:10 Average:152.70 Median:152.50 stddev:3.23 (2.1%) stddev-sans-first:3.43 18:30:24 INFO - PID 9129 | Values: 153.0 160.0 151.0 149.0 150.0 152.0 151.0 151.0 155.0 155.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 18:30:24 INFO - PID 9129 | Values: 95.0 96.0 95.0 94.0 95.0 96.0 95.0 96.0 96.0 96.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.16 (2.0%) stddev-sans-first:1.20 18:30:24 INFO - PID 9129 | Values: 56.0 55.0 55.0 56.0 58.0 57.0 57.0 58.0 58.0 57.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 18:30:24 INFO - PID 9129 | Values: 57.0 57.0 56.0 57.0 58.0 57.0 57.0 56.0 57.0 57.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:88.00 stddev:10.48 (11.9%) stddev-sans-first:11.05 18:30:24 INFO - PID 9129 | Values: 88.0 88.0 87.0 87.0 87.0 89.0 88.0 90.0 121.0 88.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:139.00 stddev:6.30 (4.5%) stddev-sans-first:6.42 18:30:24 INFO - PID 9129 | Values: 134.0 133.0 132.0 134.0 139.0 139.0 143.0 138.0 145.0 152.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.00 Median:201.50 stddev:6.58 (3.3%) stddev-sans-first:6.48 18:30:24 INFO - PID 9129 | Values: 191.0 201.0 203.0 186.0 201.0 198.0 190.0 203.0 205.0 202.0 18:30:24 INFO - PID 9129 | 18:30:24 INFO - PID 9129 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.50 stddev:1.85 (2.5%) stddev-sans-first:1.80 18:30:24 INFO - PID 9129 | Values: 77.0 77.0 75.0 73.0 72.0 73.0 74.0 77.0 76.0 75.0 18:30:24 INFO - PID 9129 | -------- Summary: end -------- 18:30:24 INFO - PID 9129 | 18:30:25 INFO - TEST-INFO | 9129: exit 0 18:30:25 INFO - TEST-OK | kraken | took 92866ms 18:30:25 INFO - SUITE-END | took 1240s 18:30:26 INFO - Completed test suite (00:20:40) 18:30:26 INFO - javascript benchmark 18:30:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6880.014254273969, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2708.2823051891246, 2721.6733991920973, 2726.127639155471, 2762.751352378287, 2764.2674691206835, 5199.532042116209, 5211.983663185681, 5236.581073514119, 5252.133397989337, 5280.313559237298, 5198.350206224222, 5216.087184742664, 5280.5247527722495, 5284.260203571503, 5330.733463326837, 4683.7892294846815, 4684.46128695201, 4709.576138147566, 4710.599599034086, 4731.90536189276, 4702.0, 4749.643776716743, 4783.402074740658, 4785.497522760113, 4838.0, 4697.553732395417, 4723.07899959508, 4730.290456431529, 4733.053389322149, 4781.0, 4688.132695451352, 4709.9764501177615, 4727.527247275245, 4741.952580474185, 4760.785764640599, 4652.55800698933, 4657.5575320344515, 4718.127146477913, 4729.834455794031, 4749.620030397595, 5152.227165925104, 5247.055530004598, 5271.341082364705, 5284.81503147388, 5285.075111855448, 5511.311086114236, 5638.872225554865, 5672.262605861253, 5673.546116310686, 5702.714864256812, 5682.772689092431, 5801.970990145022, 5811.302643682785, 5828.446297601721, 5838.591298609099, 5287.894242115136, 5299.2316114164005, 5309.628326017219, 5358.223057656696, 5367.75845086972, 5707.286589176353, 5881.911771323434, 5896.292444906639, 5900.085486749561, 5906.438888305604, 5470.398256191816, 5528.115501519818, 5644.3508996465935, 5654.46282603152, 5697.173909783141, 5649.435056494318, 5710.0, 5728.79949201776, 5740.56945729072, 5741.8564535886935, 5516.972415137899, 5578.386377498472, 5669.348024977098, 5682.602217844711, 5710.857228569319, 5632.633878797865, 5653.462921022497, 5664.0, 5711.286089238845, 5717.313922329347, 4786.1863483207935, 4791.5687588117235, 4794.832180873653, 4808.447028591687, 4832.106060378841, 4088.9591104089172, 4095.5904409559403, 4102.548719640837, 4109.198706252252, 4149.937750933738, 4713.6464765142755, 4714.6464015199, 4772.284157376422, 4787.114383838932, 4796.472388037313, 5713.914291285634, 5730.0, 5744.856378590569, 5770.942290577124, 5801.477866991907, 4768.833090841873, 4776.0, 4776.689515181502, 4784.832530861403, 4807.326974223612, 4980.90038199234, 5058.797648094109, 5061.468545802712, 5076.517730815566, 5080.898382032338, 5270.578353731769, 5346.893062138658, 5347.251384806208, 5365.195220716923, 5377.166539186276, 5556.861078472909, 5631.521320687787, 5714.257146570919, 5740.885182296247, 5758.827235182951, 5220.1647736362, 5278.498542638443, 5280.683159010318, 5290.25936368901, 5350.545203657577, 5575.052241118939, 5622.88754224905, 5652.463016013472, 5675.687837168995, 5689.260396148474, 5704.971475142598, 5731.627444216113, 5753.884922301447, 5764.769409223752, 5766.682832444256, 5500.80747173847, 5515.310586176728, 5544.667319960815, 5582.8325150245555, 5592.328920529562, 5556.777728890961, 5564.10974244119, 5574.637648552831, 5576.247206627054, 5585.469380408855, 5356.384015838228, 5392.757325920422, 5417.079096553674, 5434.701091439851, 5488.4785945335125, 5465.836024919259, 5485.094959331665, 5517.44825517445, 5529.723513824373, 5627.634203776742, 5462.6449280798215, 5470.015397228378, 5470.507654311131, 5495.917561236664, 5499.642523235977], "value": 5162.561057116012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.9526785491089, 670.4937771982154, 696.5368030259876, 1201.633501781956, 1259.3451405269254, 33103.0, 33918.49122263168, 33992.0, 34053.97838064859, 34122.0, 32864.34271314572, 32995.50506742395, 33170.17074573131, 33212.50181247277, 33230.8338458308, 6219.346968568303, 6417.903731444032, 6441.389652586853, 6597.37324954131, 6688.598684078971, 6590.472762179014, 6685.264620891722, 6688.230853451842, 6706.1558071530235, 6742.089817874597, 6698.296678848724, 6707.0, 6723.529352945296, 6737.0, 6746.224184218804, 6668.9666551667415, 6682.83292917676, 6683.5655682380975, 6698.363655452724, 6698.39714425704, 6682.465402767767, 6707.262201157869, 6722.462203023795, 6723.831904202385, 6737.19153701554, 31347.05958821239, 31353.529697054564, 31499.070204554962, 31500.227451098122, 31929.0, 3053.175642576492, 3054.0990407829745, 3087.289923317627, 3089.4439000979814, 3106.8601912913746, 24529.386765331008, 24543.14099006526, 24579.13973010936, 24592.0, 24648.260552183463, 3032.863521141554, 3078.6921307869034, 3087.5831762711973, 3128.7966282191815, 3139.8901038463773, 142624.0, 143694.0, 143965.0, 154776.0, 157211.2139439307, 38827.417588735625, 38828.6117138825, 39004.0, 39062.804685976385, 39158.412623810094, 40930.0, 41045.79477102655, 41050.973725657095, 41104.0, 43839.0, 12531.624051278477, 12693.428795704216, 12693.873061269269, 12707.682307942376, 12877.549285774952, 10080.243981701402, 10178.13485853696, 10207.489625518843, 10263.384196948207, 10302.484875756183, 12608.495660173674, 12629.747405051847, 12673.93663031679, 12713.110082294335, 12753.107282490322, 5528.530074943595, 5533.253010843565, 5534.833954981357, 5570.916436253459, 5608.523275521627, 855.9957200213959, 887.9112088791069, 909.4770506958525, 913.1827014821697, 941.0824446164935, 19893.701594476093, 20525.0, 20784.48038799042, 21462.356129316144, 21468.78531214668, 979.8089372572423, 987.3138168972495, 989.871316728835, 992.8560358748085, 996.9800603988025, 11141.331520108819, 11173.83239251412, 11198.160137989684, 11266.293304257259, 11384.146189035855, 175939.0, 176452.0, 176768.0, 177416.0, 178316.10841945707, 40042.399364009565, 40451.0, 40668.389974150414, 40684.389734154014, 40712.0, 1224.7366816134574, 1236.6722818453118, 1246.9750604987848, 1254.078252484405, 1259.2633309514038, 19538.90230548838, 19881.502962426053, 19963.500912477306, 20612.175512979313, 20952.47618809542, 28913.132606021853, 36652.0, 37210.25579488449, 37293.4405983905, 37388.6261137396, 161413.0, 162429.0, 163316.0, 163519.5600549931, 163566.0, 29222.707772922, 30032.3993520124, 30109.247268818453, 30462.238444039078, 30529.08412747621, 35058.123546911535, 35932.820335898155, 36121.458178127876, 36192.63807361998, 36952.445713313784, 26595.867020664773, 27179.184624461297, 27399.726002739717, 27609.447811043265, 28515.144545663665, 26562.203133906012, 26825.463490730468, 27121.72878271192, 27459.03893363723, 28723.856380717963, 30302.242443938198, 30564.0, 30665.693343067178, 30723.0, 30770.076897693107, 25645.743542564334, 26175.1944494429, 26446.206613801616, 27152.321191970357, 27275.181744547695, 19634.312799051964, 21698.65566879501, 22157.55684886261, 22186.112555498246, 22194.88902555477], "value": 14507.961762238714, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.570860246837, 426.4583978347497, 434.42221844946226, 439.3190554640308, 445.3031006474869, 17940.641187176265, 18736.25054997802, 18745.437636870898, 19143.521411964673, 19983.900080499578, 19584.412467625993, 19961.10175042123, 20026.29907953222, 20035.799642003574, 20084.29704960327, 5563.248961390201, 5665.093585026397, 5674.404187560309, 5686.3744988051285, 5694.6867922264255, 5540.584456165783, 5609.382967873531, 5616.943830561703, 5627.352854421732, 5636.7463464144, 5291.1798671206025, 5581.0, 5587.357453892813, 5608.074667679828, 5626.915596266039, 5427.701476418795, 5490.670559766427, 5494.36814766301, 5501.229827824108, 5523.4200408956885, 4961.156603377434, 4968.056069346812, 4985.202367621199, 4997.225430058346, 5000.274960130797, 23442.296731098093, 23811.404714882094, 23850.642240366407, 23854.284371468882, 23861.642075368884, 1618.8381161883835, 1633.5834362237554, 1634.6730653869154, 1638.361039194715, 1640.7866977292995, 15558.144302063381, 15605.921970390076, 16033.118178500177, 16212.0, 16278.83721162785, 2064.783197764228, 2070.8136267735977, 2112.0, 2122.936311910645, 2124.2034237161065, 94488.0, 95015.04984950132, 97881.0, 99175.50412247964, 99342.5032874831, 11200.21598488098, 11244.49399777012, 11261.605843795427, 11497.0, 11508.53965841357, 15960.680786384208, 16005.439809606607, 16020.235244717482, 16094.517164485083, 16151.273192706356, 7302.160251571137, 7513.2862378074, 7600.239976002466, 7705.267999540035, 7746.41901857363, 6929.861402771916, 6941.409980151642, 6974.26770189133, 7049.436045116378, 7055.118110236221, 7392.408607311402, 7441.813954651068, 7496.512726672749, 7593.658285377061, 7644.885326720104, 2053.743282089739, 2060.1759296281607, 2062.7318448601586, 2112.3134981131193, 2212.6570381590877, 824.7690646618956, 851.2764150472049, 876.9649214031494, 899.1727610598265, 902.3773596218588, 17415.129243537773, 17490.737638935425, 17916.372926947493, 17919.73120403195, 17940.0, 867.1068799136899, 878.0780180810124, 897.1028971028971, 897.8428774964485, 908.6274627402734, 9322.347435679438, 9837.458939758239, 9838.557264923096, 9956.103950644332, 10037.498125093862, 352863.0, 381087.0, 382012.0, 382609.0, 390580.0, 87798.56100719456, 91519.54240228757, 91770.0, 92523.0, 92631.53684231536, 972.7762614598682, 991.1575161112996, 1095.1950316517352, 1113.8830422805652, 1130.4065365682918, 18208.271669133086, 18279.725804112684, 18599.81400185981, 18992.0, 19154.904225478782, 45086.549134508234, 45488.77255613701, 45539.772301138284, 45989.54010459853, 46030.309545357515, 56283.0, 56341.71829140828, 56409.43590564206, 56544.71727641336, 57191.142132868874, 9588.328816982745, 9672.129508344282, 9717.611295548098, 9731.318807683394, 9861.408315501092, 13981.300934953415, 14043.719125617226, 14193.432262709375, 14211.431542738175, 14231.0, 13081.542146024844, 13155.276459794803, 13161.868381316064, 13260.071794974645, 13293.268870211845, 12279.631611051684, 12356.691082723004, 12542.0, 12588.559400421307, 12684.175528590613, 12105.69735756578, 12354.567590134302, 12459.439325230205, 12462.376881156088, 12528.185667931555, 8817.426867253607, 9267.67563135287, 9514.762130946781, 9587.089226523749, 9633.08485693858, 13412.865871341162, 13576.93211533936, 13720.90232781395, 13776.24230667323, 13839.861601383856], "value": 9446.193648679602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.2174251963781, 1312.0422091872927, 1322.570164696474, 1324.0863803975255, 1336.9532066377678, 10486.213533984954, 10915.672529824098, 10921.453927303623, 10977.231593788418, 11263.718407039829, 10842.620508282213, 10986.945065274662, 10992.890071099286, 11027.669169924895, 11124.0, 2116.111233282021, 2147.473868902121, 2170.077716970289, 2172.9891350543303, 2177.68423578581, 2085.113826623679, 2138.7112739780086, 2145.549434618732, 2149.441145302225, 2150.591387636352, 2062.247279742898, 2094.424033390822, 2096.5178009057927, 2102.0645812613393, 2108.7996640319143, 2054.969175462369, 2061.4537147655883, 2070.896455177243, 2071.30611245233, 2072.3990042887544, 1858.944231673052, 1926.4702206893076, 1958.265650381107, 2003.5692326149801, 2119.830413566911, 10660.147188225, 10788.0, 10788.73028174294, 10795.190360722898, 10850.186236032328, 5515.696636684981, 5743.282089738783, 5762.250907382056, 5767.625104368202, 5780.942190578083, 3152.5271209318557, 3269.5095735639607, 3293.110860067792, 3308.024132880782, 3313.1385839681857, 933.4446004627235, 951.6669165791986, 965.6089283840056, 966.9564869580815, 970.1608108985677, 15792.0, 15933.601659958478, 15991.440299589574, 15993.800464965057, 16023.679526409407, 4767.499412561631, 4787.473377928425, 4810.975945120322, 4911.607071434277, 5012.298278241049, 11822.467988940518, 11910.285382877055, 11946.0, 11952.581659642045, 11976.401179941142, 5534.806281780199, 5675.602707810413, 5677.489025987681, 5679.4320567943705, 5680.40355762639, 5150.304708864331, 5201.739913004335, 5229.738513074331, 5234.502722241381, 5242.842714718565, 3976.383660532622, 4045.977011494253, 4060.39094135882, 4130.359794231899, 4154.273002224599, 1210.1105687319814, 1214.2046959241711, 1221.712897469094, 1243.160866415166, 1243.2664727810636, 624.1480379282337, 705.4532737128766, 707.8230442389403, 721.7113154738147, 728.7194430144433, 5909.704514774244, 5964.075568286922, 5964.761409543657, 5982.282126144803, 6057.515398768088, 826.9131741167212, 857.3998201259019, 861.3195575495414, 863.313665635821, 883.6907082521195, 3510.613832478425, 3553.697935675445, 3621.2395396966403, 3697.0757310672334, 3975.4434379186937, 13322.866771332356, 13847.0, 13856.653583660287, 13918.234497102756, 13926.025178237629, 13566.525171618947, 13707.657308567366, 13740.0, 13794.862051379558, 13855.722885542233, 7471.402287816962, 7663.770086897402, 7782.143964163937, 7793.493422927491, 7852.411069169721, 6049.0, 6120.479759220516, 6130.111133885473, 6136.32500424944, 6189.84525386869, 12512.687182820502, 12746.10777245584, 12806.103572749818, 12889.355532223164, 13065.412056457671, 12810.743785124432, 13137.277449739973, 13242.53651122206, 13435.0, 13466.865331346562, 8903.287736980896, 9239.72280831576, 9247.075292470969, 9256.25949923991, 9267.165955064076, 10017.799644007226, 10116.443595602312, 10151.84772228432, 10159.949200253952, 10174.898251017692, 8009.159038300894, 8392.706255281037, 8416.579171041545, 8455.492670439793, 8496.320294376312, 8272.37957153204, 8290.170982901662, 8310.87533686983, 8418.87371689413, 8474.576271186294, 7140.6786694599905, 7263.382612477999, 7287.927120728937, 7308.598027108347, 7311.647345241147, 4985.351904252424, 5008.373953255843, 5013.548780609763, 5193.298904647824, 5254.3169387979315, 4872.196087645641, 4872.269159626085, 4934.555889969776, 4964.8758781030765, 5021.874453138701], "value": 4817.611726640647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.96040435552084, 379.2017802525683, 382.2164562646575, 384.39841647821174, 389.6473691309364, 5380.596455265852, 5552.806146678463, 5602.957338395446, 5607.775688972436, 5610.410906854782, 5356.866078348034, 5411.269478620385, 5411.648242864211, 5419.485148910857, 5456.454354564542, 4152.252594532983, 4184.309588917825, 4204.306289462235, 4210.179015092058, 4214.4099826024385, 4214.136102099063, 4215.747055176699, 4217.734679596124, 4219.620234178923, 4224.112936283384, 4174.686898482611, 4178.749275043507, 4181.916361672765, 4182.184474027566, 4184.686148538856, 4172.207280616673, 4178.22702799983, 4181.9508440864065, 4182.581741825824, 4183.330667093281, 3693.5013773140818, 3718.995871114811, 3723.6462536059303, 3725.9008592465016, 3732.720045996561, 5370.0, 5382.596305277119, 5386.9900992077355, 5404.270423492818, 5415.10650742627, 4933.55597996182, 4940.308356830046, 4945.060438516671, 4952.281919121707, 4956.628252881048, 5752.712364381764, 5767.711614419304, 5775.191473193756, 5787.13193021046, 5810.82567522975, 4122.0, 4154.459920210384, 4166.83332666693, 4174.645155161815, 4185.602367775056, 5861.325947516048, 5863.237779088691, 5970.791022314198, 6065.575409721321, 6184.474319682788, 4156.8129434175535, 4194.958050419456, 4206.768627725504, 4214.620684138442, 4216.24107660624, 4245.299525578307, 4254.936175957363, 4259.424977628042, 4280.400743895857, 4280.807363668642, 4693.624510039189, 4838.491958344393, 4842.806287748521, 4855.0, 4856.465788763304, 5759.337676167211, 5778.27771528559, 5780.653160810365, 5789.3921138279875, 5811.360750317462, 1464.736347457468, 1469.5077149154938, 1470.786735923285, 1474.3586539855198, 1481.3185934470048, 985.3693636072919, 992.1318846009741, 1014.3356101753363, 1020.0819262663514, 1028.1209565821264, 4965.90068198634, 4968.677035992649, 4979.779953911315, 4982.352294201731, 5027.472115427828, 5999.100134979788, 6004.919114559334, 6030.7889223876955, 6038.792241551707, 6039.1545183674325, 4943.555080042742, 4972.303877457159, 4991.7004979700605, 4993.650444468925, 5003.724795136302, 3155.7002084802366, 3171.2230503526785, 3178.396104740092, 3188.4739018062223, 3196.2488815128427, 5526.50261476469, 5538.501534861801, 5586.776528938878, 5587.580931430159, 5622.606417550732, 6116.938830611637, 6134.386561343919, 6150.661713605795, 6199.783007594712, 6223.564350495421, 5527.364353099365, 5550.224887556141, 5564.304461942257, 5570.832875013756, 5572.523281330369, 5984.251968503937, 5990.31111422192, 6021.217241758543, 6028.57799953999, 6029.0, 5926.762929482772, 5939.970300148471, 5971.253593300838, 5972.848870035284, 5980.9401905980385, 5211.879445919146, 5335.786568537215, 5510.338759348904, 5592.888142237214, 5600.887982240414, 4160.3343465046655, 4203.015858740328, 4214.1571685662375, 4234.703570750018, 4256.38282449037, 5978.790742323998, 6017.247844019497, 6043.244594425697, 6057.363976782551, 6062.393760623902, 5568.1091025435735, 5757.568182386254, 5787.9710601448405, 5811.1573821794755, 5825.242718446575, 5691.686957217227, 5758.3090029196765, 5795.33353664334, 5795.33353664334, 5841.94158058414, 5644.8024319148635, 5652.823662889735, 5660.235868157746, 5690.601657883908, 5691.658500489983, 5892.705364731832, 5900.321463031806, 5901.989985107541, 5930.970345148246, 5935.5548333875995, 5697.914531281951, 5698.743556540048, 5715.342735585461, 5724.542036637143, 5734.741936612946], "value": 4361.9188944114085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.5820570349237, 692.217793892901, 750.8836130399786, 756.5649751392949, 788.9053313602367, 12622.116451848362, 13680.247586382746, 13703.451861925523, 13732.862671373283, 14811.851881481181, 16540.0, 16648.1675916204, 16701.164941752926, 16777.580560485992, 16899.070551119683, 838.5765188579774, 860.5095095795399, 864.2783275964578, 864.4899509289518, 864.5504337744369, 894.5974311559792, 900.2303030908577, 913.8126684029792, 914.4696076275744, 916.9908300917006, 934.985975210369, 941.0448394879203, 943.528235882059, 945.1540870920522, 945.3382632157483, 934.56075644447, 938.6855403439856, 940.9435433873955, 941.7080704981478, 942.575840871607, 684.8869936460478, 687.7661595057655, 688.0779755128102, 689.9896501552481, 691.4779341597113, 13769.31153442334, 13882.583522494342, 13886.652833679138, 13889.652758681013, 13931.512397066053, 14933.253337333199, 15241.466548670855, 15359.539213823604, 15451.304691288806, 15517.922410387988, 12661.746765064647, 12729.363531823465, 13214.603561893158, 13303.467861285537, 13428.060035797498, 2960.3339248669095, 2987.6414830220297, 2989.0733872499377, 2991.1923780579123, 2996.056242283674, 83009.0, 84114.317713646, 85069.57465212696, 86230.99999999937, 86713.0, 13087.476500940045, 13214.669633259246, 13271.402786874614, 13470.595882123553, 13486.662833429244, 23523.882380587987, 24252.0, 24341.513169736507, 24349.756502435102, 24362.512749744907, 6120.540959428061, 6218.22272215973, 6272.090546870678, 6294.181756371642, 6352.428281454691, 2880.438314528647, 2979.657339405953, 3025.0924722583136, 3062.1732132324146, 3075.5386691996378, 3600.027992442026, 3661.853525858989, 3674.063113905937, 3684.521012268388, 3737.9252414951548, 718.468333433266, 720.2365492577884, 739.6153999920011, 743.1750756660103, 743.9590822504814, 548.5200449606594, 598.6049207523014, 608.60744819592, 622.8256088295285, 632.0929466215995, 9688.515574221401, 10203.183745300357, 10358.741031474123, 10442.164626829835, 10903.127749779998, 589.8672798620362, 599.349705569462, 606.5390303369383, 608.5466327585976, 622.7664625765339, 4765.642576806684, 4902.117618828645, 4954.47977962316, 5063.088644044107, 5084.211947148198, 85413.0, 86354.56822715847, 86385.0, 86540.0, 90951.54524227469, 74401.6279918597, 75710.0, 75732.62133689407, 76828.61585692035, 77034.0, 65561.6721916397, 66876.66561667257, 66910.66544667343, 67081.66459167673, 69012.654936725, 8373.790655233424, 8614.698485552975, 8635.309175265838, 8636.395452318277, 8876.911230887608, 28907.0, 28953.13140605785, 29147.708522914498, 29228.853855730584, 29945.700542995164, 37798.244035118594, 37944.0, 39005.0, 39412.40881386839, 40057.0, 12656.810147847606, 12798.232106073665, 12995.675108122372, 13004.479820807062, 13015.869841301466, 14431.278436078364, 14450.421983120557, 14571.41714331415, 14599.270036498345, 14812.333444995216, 13704.725905481635, 13734.381952812348, 14296.499622513162, 15133.016353936959, 15329.923350383177, 13546.0, 13716.588502344946, 13818.86181138216, 15865.444709435576, 16219.107949062443, 14365.640858978191, 14634.853651463349, 15329.6167595811, 15361.078335299917, 15536.300866461263, 10464.162866970471, 10471.790564188826, 10541.57833686644, 10664.826869044555, 11437.656870293904, 9958.850617240892, 10815.513301901276, 11007.944960275147, 11292.830607541058, 11443.542258309575], "value": 7132.903028917867, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 112.0, 111.0, 116.0, 115.0, 115.0, 116.0, 114.0, 116.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 123.0, 174.0, 128.0, 129.0, 124.0, 123.0, 146.0, 125.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 166.0, 167.0, 171.0, 172.0, 168.0, 164.0, 166.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 78.0, 109.0, 76.0, 75.0, 76.0, 76.0, 106.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 112.0, 84.0, 84.0, 83.0, 98.0, 84.0, 83.0, 110.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0, 116.0, 115.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 160.0, 151.0, 149.0, 150.0, 152.0, 151.0, 151.0, 155.0, 155.0], "value": 152.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 58.0, 57.0, 57.0, 58.0, 58.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 58.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 87.0, 89.0, 88.0, 90.0, 121.0, 88.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 132.0, 134.0, 139.0, 139.0, 143.0, 138.0, 145.0, 152.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 201.0, 203.0, 186.0, 201.0, 198.0, 190.0, 203.0, 205.0, 202.0], "value": 198.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 73.0, 72.0, 73.0, 74.0, 77.0, 76.0, 75.0], "value": 74.9, "unit": "score"}]}]} 18:30:26 INFO - Return code: 0 18:30:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:30:26 INFO - # TBPL SUCCESS # 18:30:26 INFO - Running post-action listener: _resource_record_post_action 18:30:26 INFO - [mozharness: 2017-06-01 01:30:26.181032Z] Finished run-tests step (success) 18:30:26 INFO - Running post-run listener: _resource_record_post_run 18:30:26 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 412704768; Read time: 12; Write time: 239488 18:30:26 INFO - TinderboxPrint: CPU usage
12.7% 18:30:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:30:26 INFO - TinderboxPrint: I/O write bytes / time
412,704,768 / 239,488 18:30:26 INFO - TinderboxPrint: CPU idle
8,754.0 (87.3%) 18:30:26 INFO - TinderboxPrint: CPU user
1,226.4 (12.2%) 18:30:26 INFO - TinderboxPrint: Swap in / out
0 / 0 18:30:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101056512; Read time: 0; Write time: 67592 18:30:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:30:26 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 0; Write bytes: 311648256; Read time: 0; Write time: 171896 18:30:26 INFO - Running post-run listener: _upload_blobber_files 18:30:26 INFO - Blob upload gear active. 18:30:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:26 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 18:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:30:27 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:30:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:30 INFO - (blobuploader) - INFO - Done attempting. 18:30:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:30:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:31 INFO - (blobuploader) - INFO - Done attempting. 18:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:30:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:34 INFO - (blobuploader) - INFO - Done attempting. 18:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:35 INFO - (blobuploader) - INFO - Done attempting. 18:30:35 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:35 INFO - Return code: 0 18:30:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf3ecc1c3ef17f83401614fbbc65f99b3a59818f63a9ae5439fedb93638e6c5c43b2b7962fe29e3f50560fa92836e78a92522089a09af463619e3e21e473716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7451cf6dd0c1b52b837c20e5edeaefb36ccf7b8ccdeee3849cb2a756f73e1574c63c5f06f7088a51290a915640462e906f480549c16bd06411b387681435b5d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13df26599d4875286b3806a2b7b7e1d8f7638be82b50d1cbdfd969076c73b2894b64c28dbbdff2f31e5e87f165a9ed8117d3146b3ad96ea7d134f6784fcfcc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fcf8018d6a93d31dde5bd82101069cb8a75371ea0f96bf188d7f2f77340f58d17fcabb080bab2238510daeef69dd103d27dafa2a6a947d39ff28e8c00c5187"} 18:30:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:35 INFO - Contents: 18:30:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf3ecc1c3ef17f83401614fbbc65f99b3a59818f63a9ae5439fedb93638e6c5c43b2b7962fe29e3f50560fa92836e78a92522089a09af463619e3e21e473716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7451cf6dd0c1b52b837c20e5edeaefb36ccf7b8ccdeee3849cb2a756f73e1574c63c5f06f7088a51290a915640462e906f480549c16bd06411b387681435b5d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13df26599d4875286b3806a2b7b7e1d8f7638be82b50d1cbdfd969076c73b2894b64c28dbbdff2f31e5e87f165a9ed8117d3146b3ad96ea7d134f6784fcfcc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fcf8018d6a93d31dde5bd82101069cb8a75371ea0f96bf188d7f2f77340f58d17fcabb080bab2238510daeef69dd103d27dafa2a6a947d39ff28e8c00c5187"} 18:30:35 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:35 INFO - Copying logs to upload dir... 18:30:35 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1325.631182 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2017-05-31 18:30:34.325875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:34.333844) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf3ecc1c3ef17f83401614fbbc65f99b3a59818f63a9ae5439fedb93638e6c5c43b2b7962fe29e3f50560fa92836e78a92522089a09af463619e3e21e473716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7451cf6dd0c1b52b837c20e5edeaefb36ccf7b8ccdeee3849cb2a756f73e1574c63c5f06f7088a51290a915640462e906f480549c16bd06411b387681435b5d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13df26599d4875286b3806a2b7b7e1d8f7638be82b50d1cbdfd969076c73b2894b64c28dbbdff2f31e5e87f165a9ed8117d3146b3ad96ea7d134f6784fcfcc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fcf8018d6a93d31dde5bd82101069cb8a75371ea0f96bf188d7f2f77340f58d17fcabb080bab2238510daeef69dd103d27dafa2a6a947d39ff28e8c00c5187"} build_url:https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdf3ecc1c3ef17f83401614fbbc65f99b3a59818f63a9ae5439fedb93638e6c5c43b2b7962fe29e3f50560fa92836e78a92522089a09af463619e3e21e473716", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7451cf6dd0c1b52b837c20e5edeaefb36ccf7b8ccdeee3849cb2a756f73e1574c63c5f06f7088a51290a915640462e906f480549c16bd06411b387681435b5d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13df26599d4875286b3806a2b7b7e1d8f7638be82b50d1cbdfd969076c73b2894b64c28dbbdff2f31e5e87f165a9ed8117d3146b3ad96ea7d134f6784fcfcc00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75fcf8018d6a93d31dde5bd82101069cb8a75371ea0f96bf188d7f2f77340f58d17fcabb080bab2238510daeef69dd103d27dafa2a6a947d39ff28e8c00c5187"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:34.361622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:34.361977) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1496271291.618070-1539604926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:34.441224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 18:30:34.444692) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 18:30:34.445076) ========= ========= Total master_lag: 0.17 =========