builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1498480560.01 results: success (0) revision: 42593af5ec7ec9d5a07c9c0e899ac99244d15ae6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.009401) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.009890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.010207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.057417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.057786) ========= 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=00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-26 05:36:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-06-26 05:36:00 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177799 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.259673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.260067) ========= 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=00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017370 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.309226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:00.312582) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42593af5ec7ec9d5a07c9c0e899ac99244d15ae6 --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 42593af5ec7ec9d5a07c9c0e899ac99244d15ae6 --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=00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-26 05:36:00,310 truncating revision to first 12 chars 2017-06-26 05:36:00,310 Setting DEBUG logging. 2017-06-26 05:36:00,310 attempt 1/10 2017-06-26 05:36:00,310 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42593af5ec7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-26 05:36:00,805 unpacking tar archive at: mozilla-central-42593af5ec7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:01.191674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:01.191972) ========= script_repo_revision: 42593af5ec7ec9d5a07c9c0e899ac99244d15ae6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:01.192334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:01.195624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-26 05:36:01.211698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-06-26 05:36:01.212006) ========= /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=00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:36:01 INFO - MultiFileLogger online at 20170626 05:36:01 in /builds/slave/test 05:36:01 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 05:36:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:01 INFO - {'append_to_log': False, 05:36:01 INFO - 'base_work_dir': '/builds/slave/test', 05:36:01 INFO - 'blob_upload_branch': 'Firefox', 05:36:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:01 INFO - 'branch': 'Firefox', 05:36:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:01 INFO - 'config_files': ('talos/linux_config.py',), 05:36:01 INFO - 'default_actions': ('clobber', 05:36:01 INFO - 'read-buildbot-config', 05:36:01 INFO - 'download-and-extract', 05:36:01 INFO - 'populate-webroot', 05:36:01 INFO - 'create-virtualenv', 05:36:01 INFO - 'install', 05:36:01 INFO - 'setup-mitmproxy', 05:36:01 INFO - 'run-tests'), 05:36:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:01 INFO - 'download_minidump_stackwalk': True, 05:36:01 INFO - 'download_symbols': 'ondemand', 05:36:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:01 INFO - 'gecko_profile': False, 05:36:01 INFO - 'gecko_profile_interval': 0, 05:36:01 INFO - 'installer_path': 'installer.exe', 05:36:01 INFO - 'log_level': 'info', 05:36:01 INFO - 'log_name': 'talos', 05:36:01 INFO - 'log_to_console': True, 05:36:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:36:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:36:01 INFO - 'opt_config_files': (), 05:36:01 INFO - 'pip_index': False, 05:36:01 INFO - 'suite': 'dromaeojs-e10s', 05:36:01 INFO - 'system_bits': '32', 05:36:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:01 INFO - 'title': 'talos-linux64-ix-016', 05:36:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:01 INFO - 'use_talos_json': True, 05:36:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:01 INFO - 'work_dir': 'build'} 05:36:01 INFO - [mozharness: 2017-06-26 12:36:01.420527Z] Running clobber step. 05:36:01 INFO - Running pre-action listener: _resource_record_pre_action 05:36:01 INFO - Running main action method: clobber 05:36:01 INFO - rmtree: /builds/slave/test/build 05:36:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:02 INFO - Running post-action listener: _resource_record_post_action 05:36:02 INFO - [mozharness: 2017-06-26 12:36:02.407782Z] Finished clobber step (success) 05:36:02 INFO - [mozharness: 2017-06-26 12:36:02.407882Z] Running read-buildbot-config step. 05:36:02 INFO - Running pre-action listener: _resource_record_pre_action 05:36:02 INFO - Running main action method: read_buildbot_config 05:36:02 INFO - Using buildbot properties: 05:36:02 INFO - { 05:36:02 INFO - "project": "", 05:36:02 INFO - "product": "firefox", 05:36:02 INFO - "who": "cbook@mozilla.com", 05:36:02 INFO - "installer_path": "public/build/target.tar.bz2", 05:36:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:36:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:36:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:36:02 INFO - "stage_platform": "linux64-pgo", 05:36:02 INFO - "basedir": "/builds/slave/test", 05:36:02 INFO - "buildnumber": 33, 05:36:02 INFO - "platform": "ubuntu64_hw", 05:36:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:36:02 INFO - "slavebuilddir": "test", 05:36:02 INFO - "taskId": "Ofd_JfX8QpqG02kahP3T9Q", 05:36:02 INFO - "branch": "mozilla-central", 05:36:02 INFO - "script_repo_revision": "production", 05:36:02 INFO - "revision": "42593af5ec7ec9d5a07c9c0e899ac99244d15ae6", 05:36:02 INFO - "slavename": "talos-linux64-ix-016", 05:36:02 INFO - "repo_path": "mozilla-central" 05:36:02 INFO - } 05:36:02 INFO - Finding installer, test and symbols from parent task. 05:36:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ofd_JfX8QpqG02kahP3T9Q'}, attempt #1 05:36:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ofd_JfX8QpqG02kahP3T9Q'}, attempt #1 05:36:03 INFO - Task dependencies: cej7SkrjSWuOBfebG5uVaw 05:36:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw'}, attempt #1 05:36:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2 05:36:03 INFO - Set test_url: https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/test_packages.json 05:36:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.crashreporter-symbols.zip 05:36:03 INFO - Running post-action listener: _resource_record_post_action 05:36:03 INFO - [mozharness: 2017-06-26 12:36:03.919821Z] Finished read-buildbot-config step (success) 05:36:03 INFO - [mozharness: 2017-06-26 12:36:03.920040Z] Running download-and-extract step. 05:36:03 INFO - Running pre-action listener: _resource_record_pre_action 05:36:03 INFO - Running main action method: download_and_extract 05:36:03 INFO - mkdir: /builds/slave/test/build/tests 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:03 INFO - trying https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.test_packages.json 05:36:03 INFO - Downloading https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:36:04 INFO - Downloaded 989 bytes. 05:36:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:36:04 INFO - Using the following test package requirements: 05:36:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:36:04 INFO - u'common': [u'target.common.tests.zip'], 05:36:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:36:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:36:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:36:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:36:04 INFO - u'mozbase': [u'target.common.tests.zip'], 05:36:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:36:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:36:04 INFO - u'web-platform': [u'target.common.tests.zip', 05:36:04 INFO - u'target.web-platform.tests.tar.gz'], 05:36:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:36:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:36:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.common.tests.zip 05:36:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:36:04 INFO - Fetch https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.common.tests.zip into memory 05:36:05 INFO - Content-Length response header: 68370845 05:36:05 INFO - Bytes received: 68370845 05:36:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:36:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.common.tests.zip 05:36:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:36:16 INFO - Fetch https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.common.tests.zip into memory 05:36:18 INFO - Content-Length response header: 68370845 05:36:18 INFO - Bytes received: 68370845 05:36:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.talos.tests.zip 05:36:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:36:30 INFO - Fetch https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.talos.tests.zip into memory 05:36:30 INFO - Content-Length response header: 14441319 05:36:30 INFO - Bytes received: 14441319 05:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:31 INFO - trying https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2 05:36:31 INFO - Downloading https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:36:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:36:32 INFO - Downloaded 62785931 bytes. 05:36:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2 05:36:32 INFO - mkdir: /builds/slave/test/properties 05:36:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:32 INFO - Contents: 05:36:32 INFO - build_url:https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2 05:36:32 INFO - Running post-action listener: _resource_record_post_action 05:36:32 INFO - Running post-action listener: set_extra_try_arguments 05:36:32 INFO - [mozharness: 2017-06-26 12:36:32.229816Z] Finished download-and-extract step (success) 05:36:32 INFO - [mozharness: 2017-06-26 12:36:32.229914Z] Running populate-webroot step. 05:36:32 INFO - Running pre-action listener: _resource_record_pre_action 05:36:32 INFO - Running main action method: populate_webroot 05:36:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:32 INFO - '--tppagecycles', 05:36:32 INFO - '7'], 05:36:32 INFO - 'tests': ['tsvgm']}}, 05:36:32 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['damp', 'tps']}, 05:36:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'tests': ['damp', 'tps']}, 05:36:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['dromaeo_dom']}, 05:36:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:36:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:36:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:36:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['a11yr', 05:36:32 INFO - 'ts_paint', 05:36:32 INFO - 'tpaint', 05:36:32 INFO - 'sessionrestore', 05:36:32 INFO - 'sessionrestore_no_auto_restore', 05:36:32 INFO - 'tabpaint']}, 05:36:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:32 INFO - 'ts_paint', 05:36:32 INFO - 'tpaint', 05:36:32 INFO - 'sessionrestore', 05:36:32 INFO - 'sessionrestore_no_auto_restore', 05:36:32 INFO - 'tabpaint']}, 05:36:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:36:32 INFO - 'ts_paint', 05:36:32 INFO - 'tpaint', 05:36:32 INFO - 'sessionrestore', 05:36:32 INFO - 'sessionrestore_no_auto_restore', 05:36:32 INFO - 'tabpaint']}, 05:36:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:36:32 INFO - 'ts_paint', 05:36:32 INFO - 'tpaint', 05:36:32 INFO - 'sessionrestore', 05:36:32 INFO - 'sessionrestore_no_auto_restore', 05:36:32 INFO - 'tabpaint']}, 05:36:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['a11yr', 05:36:32 INFO - 'ts_paint', 05:36:32 INFO - 'tpaint', 05:36:32 INFO - 'sessionrestore', 05:36:32 INFO - 'sessionrestore_no_auto_restore', 05:36:32 INFO - 'tabpaint']}, 05:36:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['a11yr', 05:36:32 INFO - 'ts_paint', 05:36:32 INFO - 'tpaint', 05:36:32 INFO - 'sessionrestore', 05:36:32 INFO - 'sessionrestore_no_auto_restore', 05:36:32 INFO - 'tabpaint']}, 05:36:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:36:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:36:32 INFO - 'bloom_basic_ref']}, 05:36:32 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:36:32 INFO - 'talos_options': ['--mitmproxy', 05:36:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:36:32 INFO - '--firstNonBlankPaint'], 05:36:32 INFO - 'tests': ['quantum_pageload_google', 05:36:32 INFO - 'quantum_pageload_youtube', 05:36:32 INFO - 'quantum_pageload_amazon', 05:36:32 INFO - 'quantum_pageload_facebook']}, 05:36:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['tsvgx', 05:36:32 INFO - 'tsvgr_opacity', 05:36:32 INFO - 'tart', 05:36:32 INFO - 'tscrollx', 05:36:32 INFO - 'cart', 05:36:32 INFO - 'tsvg_static']}, 05:36:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:32 INFO - 'tsvgr_opacity', 05:36:32 INFO - 'tart', 05:36:32 INFO - 'tscrollx', 05:36:32 INFO - 'cart', 05:36:32 INFO - 'tsvg_static']}, 05:36:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'talos_options': ['--disable-e10s'], 05:36:32 INFO - 'tests': ['tp5o']}, 05:36:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:36:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'talos_options': ['--disable-e10s', 05:36:32 INFO - '--xperf_path', 05:36:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:32 INFO - 'tests': ['tp5n']}, 05:36:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:36:32 INFO - 'talos_options': ['--xperf_path', 05:36:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:32 INFO - 'tests': ['tp5n']}}, 05:36:32 INFO - 'talos.zip': {'path': '', 05:36:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:32 INFO - Running post-action listener: _resource_record_post_action 05:36:32 INFO - [mozharness: 2017-06-26 12:36:32.244771Z] Finished populate-webroot step (success) 05:36:32 INFO - [mozharness: 2017-06-26 12:36:32.244861Z] Running create-virtualenv step. 05:36:32 INFO - Running pre-action listener: _resource_record_pre_action 05:36:32 INFO - Running main action method: create_virtualenv 05:36:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:32 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 05:36:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:36:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:36:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:32 INFO - Using real prefix '/usr' 05:36:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:34 INFO - Installing pip.................done. 05:36:34 INFO - Return code: 0 05:36:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:36:35 INFO - Reading from file tmpfile_stdout 05:36:35 INFO - Output received: 05:36:35 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) 05:36:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:35 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')]} 05:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:35 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')]} 05:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:35 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:35 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 05:36:35 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 05:36:35 INFO - Using env: {'DISPLAY': ':0', 05:36:35 INFO - 'HOME': '/home/cltbld', 05:36:35 INFO - 'LANG': 'en_US.UTF-8', 05:36:35 INFO - 'LANGUAGE': 'en_US:en', 05:36:35 INFO - 'LOGNAME': 'cltbld', 05:36:35 INFO - 'MAIL': '/var/mail/cltbld', 05:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:35 INFO - 'MOZ_NO_REMOTE': '1', 05:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:35 INFO - 'NO_EM_RESTART': '1', 05:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:35 INFO - 'PWD': '/builds/slave/test', 05:36:35 INFO - 'SHELL': '/bin/bash', 05:36:35 INFO - 'SHLVL': '1', 05:36:35 INFO - 'TERM': 'linux', 05:36:35 INFO - 'TMOUT': '86400', 05:36:35 INFO - 'USER': 'cltbld', 05:36:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:35 INFO - '_': '/tools/buildbot/bin/python'} 05:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:35 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 05:36:35 INFO - Cleaning up... 05:36:35 INFO - Return code: 0 05:36:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:35 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')]} 05:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:35 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')]} 05:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:35 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:35 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 05:36:35 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 05:36:35 INFO - Using env: {'DISPLAY': ':0', 05:36:35 INFO - 'HOME': '/home/cltbld', 05:36:35 INFO - 'LANG': 'en_US.UTF-8', 05:36:35 INFO - 'LANGUAGE': 'en_US:en', 05:36:35 INFO - 'LOGNAME': 'cltbld', 05:36:35 INFO - 'MAIL': '/var/mail/cltbld', 05:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:35 INFO - 'MOZ_NO_REMOTE': '1', 05:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:35 INFO - 'NO_EM_RESTART': '1', 05:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:35 INFO - 'PWD': '/builds/slave/test', 05:36:35 INFO - 'SHELL': '/bin/bash', 05:36:35 INFO - 'SHLVL': '1', 05:36:35 INFO - 'TERM': 'linux', 05:36:35 INFO - 'TMOUT': '86400', 05:36:35 INFO - 'USER': 'cltbld', 05:36:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:35 INFO - '_': '/tools/buildbot/bin/python'} 05:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:35 INFO - Downloading/unpacking psutil>=3.1.1 05:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:36 INFO - Installing collected packages: psutil 05:36:36 INFO - Running setup.py install for psutil 05:36:37 INFO - building 'psutil._psutil_linux' extension 05:36:37 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 05:36:38 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 05:36:38 INFO - building 'psutil._psutil_posix' extension 05:36:38 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 05:36:38 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 05:36:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:38 INFO - Successfully installed psutil 05:36:38 INFO - Cleaning up... 05:36:38 INFO - Return code: 0 05:36:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:36:38 INFO - Using env: {'DISPLAY': ':0', 05:36:38 INFO - 'HOME': '/home/cltbld', 05:36:38 INFO - 'LANG': 'en_US.UTF-8', 05:36:38 INFO - 'LANGUAGE': 'en_US:en', 05:36:38 INFO - 'LOGNAME': 'cltbld', 05:36:38 INFO - 'MAIL': '/var/mail/cltbld', 05:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:38 INFO - 'MOZ_NO_REMOTE': '1', 05:36:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:38 INFO - 'NO_EM_RESTART': '1', 05:36:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:38 INFO - 'PWD': '/builds/slave/test', 05:36:38 INFO - 'SHELL': '/bin/bash', 05:36:38 INFO - 'SHLVL': '1', 05:36:38 INFO - 'TERM': 'linux', 05:36:38 INFO - 'TMOUT': '86400', 05:36:38 INFO - 'USER': 'cltbld', 05:36:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:38 INFO - '_': '/tools/buildbot/bin/python'} 05:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:36:39 INFO - Installing collected packages: mozsystemmonitor 05:36:39 INFO - Running setup.py install for mozsystemmonitor 05:36:39 INFO - Successfully installed mozsystemmonitor 05:36:39 INFO - Cleaning up... 05:36:39 INFO - Return code: 0 05:36:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:39 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:39 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 05:36:39 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 05:36:39 INFO - Using env: {'DISPLAY': ':0', 05:36:39 INFO - 'HOME': '/home/cltbld', 05:36:39 INFO - 'LANG': 'en_US.UTF-8', 05:36:39 INFO - 'LANGUAGE': 'en_US:en', 05:36:39 INFO - 'LOGNAME': 'cltbld', 05:36:39 INFO - 'MAIL': '/var/mail/cltbld', 05:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:39 INFO - 'MOZ_NO_REMOTE': '1', 05:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:39 INFO - 'NO_EM_RESTART': '1', 05:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:39 INFO - 'PWD': '/builds/slave/test', 05:36:39 INFO - 'SHELL': '/bin/bash', 05:36:39 INFO - 'SHLVL': '1', 05:36:39 INFO - 'TERM': 'linux', 05:36:39 INFO - 'TMOUT': '86400', 05:36:39 INFO - 'USER': 'cltbld', 05:36:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:39 INFO - '_': '/tools/buildbot/bin/python'} 05:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:41 INFO - warning: no files found matching '*.txt' 05:36:41 INFO - no previously-included directories found matching 'build' 05:36:41 INFO - no previously-included directories found matching 'dist' 05:36:41 INFO - no previously-included directories found matching '.git*' 05:36:41 INFO - Installing collected packages: jsonschema, functools32 05:36:41 INFO - Running setup.py install for functools32 05:36:41 INFO - warning: no files found matching '*.txt' 05:36:41 INFO - no previously-included directories found matching 'build' 05:36:41 INFO - no previously-included directories found matching 'dist' 05:36:41 INFO - no previously-included directories found matching '.git*' 05:36:41 INFO - Successfully installed jsonschema functools32 05:36:41 INFO - Cleaning up... 05:36:41 INFO - Return code: 0 05:36:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:36:41 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')]} 05:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:41 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')]} 05:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:41 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:41 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 05:36:41 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 05:36:41 INFO - Using env: {'DISPLAY': ':0', 05:36:41 INFO - 'HOME': '/home/cltbld', 05:36:41 INFO - 'LANG': 'en_US.UTF-8', 05:36:41 INFO - 'LANGUAGE': 'en_US:en', 05:36:41 INFO - 'LOGNAME': 'cltbld', 05:36:41 INFO - 'MAIL': '/var/mail/cltbld', 05:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:41 INFO - 'MOZ_NO_REMOTE': '1', 05:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:41 INFO - 'NO_EM_RESTART': '1', 05:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:41 INFO - 'PWD': '/builds/slave/test', 05:36:41 INFO - 'SHELL': '/bin/bash', 05:36:41 INFO - 'SHLVL': '1', 05:36:41 INFO - 'TERM': 'linux', 05:36:41 INFO - 'TMOUT': '86400', 05:36:41 INFO - 'USER': 'cltbld', 05:36:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:41 INFO - '_': '/tools/buildbot/bin/python'} 05:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:36:41 INFO - Cleaning up... 05:36:41 INFO - Return code: 0 05:36:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:36:41 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')]} 05:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:41 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')]} 05:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:41 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:41 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 05:36:41 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 05:36:41 INFO - Using env: {'DISPLAY': ':0', 05:36:41 INFO - 'HOME': '/home/cltbld', 05:36:41 INFO - 'LANG': 'en_US.UTF-8', 05:36:41 INFO - 'LANGUAGE': 'en_US:en', 05:36:41 INFO - 'LOGNAME': 'cltbld', 05:36:41 INFO - 'MAIL': '/var/mail/cltbld', 05:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:41 INFO - 'MOZ_NO_REMOTE': '1', 05:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:41 INFO - 'NO_EM_RESTART': '1', 05:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:41 INFO - 'PWD': '/builds/slave/test', 05:36:41 INFO - 'SHELL': '/bin/bash', 05:36:41 INFO - 'SHLVL': '1', 05:36:41 INFO - 'TERM': 'linux', 05:36:41 INFO - 'TMOUT': '86400', 05:36:41 INFO - 'USER': 'cltbld', 05:36:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:41 INFO - '_': '/tools/buildbot/bin/python'} 05:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36:43 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 05:36:43 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 05:36:43 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 05:36:43 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 05:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:36:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36:43 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 05:36:43 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 05:36:43 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 05:36:43 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 05:36:43 INFO - Downloading docopt-0.6.1.tar.gz 05:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:43 INFO - Running setup.py install for blobuploader 05:36:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:36:43 INFO - Running setup.py install for requests 05:36:44 INFO - Running setup.py install for docopt 05:36:44 INFO - Successfully installed blobuploader requests docopt 05:36:44 INFO - Cleaning up... 05:36:44 INFO - Return code: 0 05:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:44 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')]} 05:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:44 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')]} 05:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:44 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:44 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 05:36:44 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 05:36:44 INFO - Using env: {'DISPLAY': ':0', 05:36:44 INFO - 'HOME': '/home/cltbld', 05:36:44 INFO - 'LANG': 'en_US.UTF-8', 05:36:44 INFO - 'LANGUAGE': 'en_US:en', 05:36:44 INFO - 'LOGNAME': 'cltbld', 05:36:44 INFO - 'MAIL': '/var/mail/cltbld', 05:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:44 INFO - 'MOZ_NO_REMOTE': '1', 05:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:44 INFO - 'NO_EM_RESTART': '1', 05:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:44 INFO - 'PWD': '/builds/slave/test', 05:36:44 INFO - 'SHELL': '/bin/bash', 05:36:44 INFO - 'SHLVL': '1', 05:36:44 INFO - 'TERM': 'linux', 05:36:44 INFO - 'TMOUT': '86400', 05:36:44 INFO - 'USER': 'cltbld', 05:36:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:44 INFO - '_': '/tools/buildbot/bin/python'} 05:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:44 INFO - Running setup.py (path:/tmp/pip-OG26GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:44 INFO - Running setup.py (path:/tmp/pip-85IRXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:44 INFO - Running setup.py (path:/tmp/pip-Xxlkem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:44 INFO - Running setup.py (path:/tmp/pip-nHqcsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:44 INFO - Running setup.py (path:/tmp/pip-8a3SWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:44 INFO - Running setup.py (path:/tmp/pip-GTOPhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:44 INFO - Running setup.py (path:/tmp/pip-sesLD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:45 INFO - Running setup.py (path:/tmp/pip-t_6kWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:45 INFO - Running setup.py (path:/tmp/pip-TpieBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:45 INFO - Running setup.py (path:/tmp/pip-38xag9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:45 INFO - Running setup.py (path:/tmp/pip-ai3S_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:45 INFO - Running setup.py (path:/tmp/pip-MQTT1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:45 INFO - Running setup.py (path:/tmp/pip-xvd0zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:45 INFO - Running setup.py (path:/tmp/pip-4G9Hok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:45 INFO - Running setup.py (path:/tmp/pip-oHJi31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:45 INFO - Running setup.py (path:/tmp/pip-i0sWcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:45 INFO - Running setup.py (path:/tmp/pip-tSPDYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:45 INFO - Running setup.py install for manifestparser 05:36:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:36:45 INFO - Running setup.py install for mozcrash 05:36:45 INFO - Running setup.py install for mozdebug 05:36:46 INFO - Running setup.py install for mozdevice 05:36:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Running setup.py install for mozfile 05:36:46 INFO - Running setup.py install for mozhttpd 05:36:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Running setup.py install for mozinfo 05:36:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Running setup.py install for mozInstall 05:36:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Running setup.py install for mozleak 05:36:46 INFO - Running setup.py install for mozlog 05:36:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Running setup.py install for moznetwork 05:36:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:36:46 INFO - Running setup.py install for mozprocess 05:36:46 INFO - Running setup.py install for mozprofile 05:36:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:36:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:36:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:36:47 INFO - Running setup.py install for mozrunner 05:36:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:36:47 INFO - Running setup.py install for mozscreenshot 05:36:47 INFO - Running setup.py install for moztest 05:36:47 INFO - Running setup.py install for mozversion 05:36:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:36:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:47 INFO - Cleaning up... 05:36:47 INFO - Return code: 0 05:36:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:47 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:47 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 05:36:47 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 05:36:47 INFO - Using env: {'DISPLAY': ':0', 05:36:47 INFO - 'HOME': '/home/cltbld', 05:36:47 INFO - 'LANG': 'en_US.UTF-8', 05:36:47 INFO - 'LANGUAGE': 'en_US:en', 05:36:47 INFO - 'LOGNAME': 'cltbld', 05:36:47 INFO - 'MAIL': '/var/mail/cltbld', 05:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:47 INFO - 'MOZ_NO_REMOTE': '1', 05:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:47 INFO - 'NO_EM_RESTART': '1', 05:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:47 INFO - 'PWD': '/builds/slave/test', 05:36:47 INFO - 'SHELL': '/bin/bash', 05:36:47 INFO - 'SHLVL': '1', 05:36:47 INFO - 'TERM': 'linux', 05:36:47 INFO - 'TMOUT': '86400', 05:36:47 INFO - 'USER': 'cltbld', 05:36:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:47 INFO - '_': '/tools/buildbot/bin/python'} 05:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:36:47 INFO - Running setup.py (path:/tmp/pip-bogQW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:36:47 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)) 05:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:36:47 INFO - Running setup.py (path:/tmp/pip-bwh5G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:36:47 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)) 05:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:36:47 INFO - Running setup.py (path:/tmp/pip-b85sQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:36:47 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)) 05:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:36:47 INFO - Running setup.py (path:/tmp/pip-E4utkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:36:48 INFO - Running setup.py (path:/tmp/pip-ItOAR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:36:48 INFO - Running setup.py (path:/tmp/pip-J249eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:36:48 INFO - Running setup.py (path:/tmp/pip-sWfFGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:36:48 INFO - Running setup.py (path:/tmp/pip-av1G0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:36:48 INFO - Running setup.py (path:/tmp/pip-eNbadp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:36:48 INFO - Running setup.py (path:/tmp/pip-8sBt1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:36:48 INFO - Running setup.py (path:/tmp/pip-Y5pQJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:36:48 INFO - Running setup.py (path:/tmp/pip-EfMdQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:36:48 INFO - Running setup.py (path:/tmp/pip-rVIXhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:36:48 INFO - Running setup.py (path:/tmp/pip-jJCmve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:48 INFO - Running setup.py (path:/tmp/pip-smFyqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:36:48 INFO - Running setup.py (path:/tmp/pip-TKl8xT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:36:48 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)) 05:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:36:48 INFO - Running setup.py (path:/tmp/pip-k75Ai4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:48 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)) 05:36:48 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)) 05:36:48 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)) 05:36:48 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)) 05:36:48 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)) 05:36:48 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)) 05:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:36:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:50 INFO - Downloading blessings-1.6.tar.gz 05:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:50 INFO - Installing collected packages: blessings 05:36:50 INFO - Running setup.py install for blessings 05:36:50 INFO - Successfully installed blessings 05:36:50 INFO - Cleaning up... 05:36:50 INFO - Return code: 0 05:36:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:50 INFO - Reading from file tmpfile_stdout 05:36:50 INFO - Current package versions: 05:36:50 INFO - argparse == 1.2.1 05:36:50 INFO - blessings == 1.6 05:36:50 INFO - blobuploader == 1.2.4 05:36:50 INFO - docopt == 0.6.1 05:36:50 INFO - functools32 == 3.2.3-2 05:36:50 INFO - jsonschema == 2.5.1 05:36:50 INFO - manifestparser == 1.1 05:36:50 INFO - mozInstall == 1.13 05:36:50 INFO - mozcrash == 1.0 05:36:50 INFO - mozdebug == 0.1 05:36:50 INFO - mozdevice == 0.51 05:36:50 INFO - mozfile == 1.2 05:36:50 INFO - mozhttpd == 0.7 05:36:50 INFO - mozinfo == 0.10 05:36:50 INFO - mozleak == 0.1 05:36:50 INFO - mozlog == 3.4 05:36:50 INFO - moznetwork == 0.27 05:36:50 INFO - mozprocess == 0.25 05:36:50 INFO - mozprofile == 0.28 05:36:50 INFO - mozrunner == 6.13 05:36:50 INFO - mozscreenshot == 0.1 05:36:50 INFO - mozsystemmonitor == 0.3 05:36:50 INFO - moztest == 0.8 05:36:50 INFO - mozversion == 1.4 05:36:50 INFO - psutil == 3.1.1 05:36:50 INFO - requests == 1.2.3 05:36:50 INFO - wsgiref == 0.1.2 05:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:50 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:50 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 05:36:50 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 05:36:50 INFO - Using env: {'DISPLAY': ':0', 05:36:50 INFO - 'HOME': '/home/cltbld', 05:36:50 INFO - 'LANG': 'en_US.UTF-8', 05:36:50 INFO - 'LANGUAGE': 'en_US:en', 05:36:50 INFO - 'LOGNAME': 'cltbld', 05:36:50 INFO - 'MAIL': '/var/mail/cltbld', 05:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:50 INFO - 'MOZ_NO_REMOTE': '1', 05:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:50 INFO - 'NO_EM_RESTART': '1', 05:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:50 INFO - 'PWD': '/builds/slave/test', 05:36:50 INFO - 'SHELL': '/bin/bash', 05:36:50 INFO - 'SHLVL': '1', 05:36:50 INFO - 'TERM': 'linux', 05:36:50 INFO - 'TMOUT': '86400', 05:36:50 INFO - 'USER': 'cltbld', 05:36:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:50 INFO - '_': '/tools/buildbot/bin/python'} 05:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:50 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)) 05:36:50 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)) 05:36:50 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)) 05:36:50 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)) 05:36:50 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)) 05:36:50 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)) 05:36:50 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)) 05:36:50 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)) 05:36:50 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)) 05:36:50 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:36:50 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 05:36:50 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 05:36:50 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 05:36:50 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 05:36:51 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:36:51 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)) 05:36:51 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)) 05:36:51 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)) 05:36:51 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)) 05:36:51 INFO - Installing collected packages: marionette-driver 05:36:51 INFO - Running setup.py install for marionette-driver 05:36:52 INFO - Successfully installed marionette-driver 05:36:52 INFO - Cleaning up... 05:36:52 INFO - Return code: 0 05:36:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:52 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')]} 05:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:52 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')]} 05:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:52 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 0x14fd3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x187b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, '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': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', '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 05:36:52 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 05:36:52 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 05:36:52 INFO - Using env: {'DISPLAY': ':0', 05:36:52 INFO - 'HOME': '/home/cltbld', 05:36:52 INFO - 'LANG': 'en_US.UTF-8', 05:36:52 INFO - 'LANGUAGE': 'en_US:en', 05:36:52 INFO - 'LOGNAME': 'cltbld', 05:36:52 INFO - 'MAIL': '/var/mail/cltbld', 05:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:52 INFO - 'MOZ_NO_REMOTE': '1', 05:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:52 INFO - 'NO_EM_RESTART': '1', 05:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:52 INFO - 'PWD': '/builds/slave/test', 05:36:52 INFO - 'SHELL': '/bin/bash', 05:36:52 INFO - 'SHLVL': '1', 05:36:52 INFO - 'TERM': 'linux', 05:36:52 INFO - 'TMOUT': '86400', 05:36:52 INFO - 'USER': 'cltbld', 05:36:52 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:52 INFO - '_': '/tools/buildbot/bin/python'} 05:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:36:52 INFO - Cleaning up... 05:36:52 INFO - Return code: 0 05:36:52 INFO - Running post-action listener: _resource_record_post_action 05:36:52 INFO - Running post-action listener: _start_resource_monitoring 05:36:52 INFO - Starting resource monitoring. 05:36:52 INFO - [mozharness: 2017-06-26 12:36:52.383565Z] Finished create-virtualenv step (success) 05:36:52 INFO - [mozharness: 2017-06-26 12:36:52.384064Z] Running install step. 05:36:52 INFO - Running pre-action listener: _resource_record_pre_action 05:36:52 INFO - Running main action method: install 05:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:52 INFO - Reading from file tmpfile_stdout 05:36:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:52 INFO - Reading from file tmpfile_stdout 05:36:52 INFO - Output received: 05:36:52 INFO - Usage: mozinstall [options] installer 05:36:52 INFO - Options: 05:36:52 INFO - -h, --help show this help message and exit 05:36:52 INFO - -d DEST, --destination=DEST 05:36:52 INFO - Directory to install application into. [default: 05:36:52 INFO - "/builds/slave/test"] 05:36:52 INFO - --app=APP Application being installed. [default: firefox] 05:36:52 INFO - mkdir: /builds/slave/test/build/application 05:36:52 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'] 05:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:37:10 INFO - Reading from file tmpfile_stdout 05:37:10 INFO - Output received: 05:37:10 INFO - /builds/slave/test/build/application/firefox/firefox 05:37:10 INFO - Running post-action listener: _resource_record_post_action 05:37:10 INFO - [mozharness: 2017-06-26 12:37:10.500540Z] Finished install step (success) 05:37:10 INFO - [mozharness: 2017-06-26 12:37:10.500819Z] Running setup-mitmproxy step. 05:37:10 INFO - Running pre-action listener: _resource_record_pre_action 05:37:10 INFO - Running main action method: setup_mitmproxy 05:37:10 INFO - Skipping: mitmproxy is not required 05:37:10 INFO - Running post-action listener: _resource_record_post_action 05:37:10 INFO - [mozharness: 2017-06-26 12:37:10.502060Z] Finished setup-mitmproxy step (success) 05:37:10 INFO - [mozharness: 2017-06-26 12:37:10.502294Z] Running run-tests step. 05:37:10 INFO - Running pre-action listener: _resource_record_pre_action 05:37:10 INFO - Running main action method: run_tests 05:37:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:10 INFO - Python 2.7.3 05:37:10 INFO - Return code: 0 05:37:10 INFO - grabbing minidump binary from tooltool 05:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:37:10 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 0x1879140>, '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 0x1879a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1879ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:10 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 05:37:10 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 05:37:10 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 05:37:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:10 INFO - Return code: 0 05:37:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:37:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:10 INFO - ENV: RUST_BACKTRACE is now 1 05:37:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:37:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:10 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/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:37:10 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/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 05:37:10 INFO - Using env: {'DISPLAY': ':0', 05:37:10 INFO - 'HOME': '/home/cltbld', 05:37:10 INFO - 'LANG': 'en_US.UTF-8', 05:37:10 INFO - 'LANGUAGE': 'en_US:en', 05:37:10 INFO - 'LOGNAME': 'cltbld', 05:37:10 INFO - 'MAIL': '/var/mail/cltbld', 05:37:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:10 INFO - 'MOZ_NO_REMOTE': '1', 05:37:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:37:10 INFO - 'NO_EM_RESTART': '1', 05:37:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:10 INFO - 'PWD': '/builds/slave/test', 05:37:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:10 INFO - 'RUST_BACKTRACE': '1', 05:37:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:37:10 INFO - 'SHELL': '/bin/bash', 05:37:10 INFO - 'SHLVL': '1', 05:37:10 INFO - 'TERM': 'linux', 05:37:10 INFO - 'TMOUT': '86400', 05:37:10 INFO - 'USER': 'cltbld', 05:37:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513', 05:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:10 INFO - '_': '/tools/buildbot/bin/python'} 05:37:10 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/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:37:10 INFO - mozversion application_buildid: 20170626112406 05:37:10 INFO - mozversion application_changeset: 42593af5ec7ec9d5a07c9c0e899ac99244d15ae6 05:37:10 INFO - mozversion application_display_name: Nightly 05:37:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:10 INFO - mozversion application_name: Firefox 05:37:10 INFO - mozversion application_remotingname: firefox 05:37:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:10 INFO - mozversion application_vendor: Mozilla 05:37:10 INFO - mozversion application_version: 56.0a1 05:37:10 INFO - mozversion platform_buildid: 20170626112406 05:37:10 INFO - mozversion platform_changeset: 42593af5ec7ec9d5a07c9c0e899ac99244d15ae6 05:37:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:10 INFO - mozversion platform_version: 56.0a1 05:37:10 INFO - using testdate: 1498480630 05:37:10 INFO - actual date: 1498480630 05:37:10 INFO - starting webserver on 'localhost:50320' 05:37:10 INFO - SUITE-START | Running 2 tests 05:37:10 INFO - TEST-START | dromaeo_css 05:37:10 INFO - operating with platform_type : linux_ 05:37:10 INFO - Initialising browser for dromaeo_css test... 05:37:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50320/getInfo.html -profile /tmp/tmpfKS8Bw/profile 05:37:10 INFO - TEST-INFO | started process 3357 (/builds/slave/test/build/application/firefox/firefox http://localhost:50320/getInfo.html) 05:37:19 INFO - TEST-INFO | 3357: exit 0 05:37:19 INFO - Browser initialized. 05:37:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:19 INFO - TEST-INFO | started process 3574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfKS8Bw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:31 INFO - PID 3574 | RSS: Main: 162643968 05:37:31 INFO - PID 3574 | 05:40:35 INFO - PID 3574 | Cycle 1(1): loaded http://localhost:50320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50320/tests/dromaeo/cssquery-ext.html) 05:40:36 INFO - PID 3574 | RSS: Main: 170876928 05:40:36 INFO - PID 3574 | 05:43:38 INFO - PID 3574 | Cycle 1(1): loaded http://localhost:50320/tests/dromaeo/cssquery-ext.html (next: http://localhost:50320/tests/dromaeo/cssquery-jquery.html) 05:43:38 INFO - PID 3574 | RSS: Main: 168157184 05:43:38 INFO - PID 3574 | 05:46:40 INFO - PID 3574 | Cycle 1(1): loaded http://localhost:50320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50320/tests/dromaeo/cssquery-mootools.html) 05:46:40 INFO - PID 3574 | RSS: Main: 171003904 05:46:40 INFO - PID 3574 | 05:49:42 INFO - PID 3574 | Cycle 1(1): loaded http://localhost:50320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50320/tests/dromaeo/cssquery-prototype.html) 05:49:43 INFO - PID 3574 | RSS: Main: 168984576 05:49:43 INFO - PID 3574 | 05:52:45 INFO - PID 3574 | Cycle 1(1): loaded http://localhost:50320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50320/tests/dromaeo/cssquery-yui.html) 05:52:46 INFO - PID 3574 | RSS: Main: 171003904 05:52:46 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | Cycle 1(1): loaded http://localhost:50320/tests/dromaeo/cssquery-yui.html (next: http://localhost:50320/tests/dromaeo/cssquery-dojo.html) 05:55:47 INFO - PID 3574 | RSS: Main: 170295296 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | __start_tp_report 05:55:47 INFO - PID 3574 | _x_x_mozilla_page_load 05:55:47 INFO - PID 3574 | _x_x_mozilla_page_load_details 05:55:47 INFO - PID 3574 | |i|pagename|runs| 05:55:47 INFO - PID 3574 | |0;dojo.html;3350.6816852399015;3412.897613071608;3418.4872269159623;3433.605135409429;3449.6377880322566;6169.660668663228;6202.286737025243;6203.596766210193;6208.317085120633;6230.688465576725;6269.780557680482;6271.247450305969;6298.559100862942;6315.684215789203;6345.428911397985;5507.146392309189;5514.724263786795;5527.861803454905;5544.91682624761;5631.7184140793;5541.806036788693;5552;5568.470995255465;5593.580481463886;5602.327720673525;5449.863753406157;5496.780128794843;5505.779768809243;5532.529734972532;5593.496585307301;5478;5488.890222195574;5547.639403438763;5554.416786237468;5562.554995600342;5459.69971651559;5516.420775818561;5522.972385138049;5535.944640553583;5553.194786755897;6223.626582405071;6244.313125556185;6259.061140828867;6272.2786879508985;6274.152989346426;6622.701978410983;6747.561408508481;6778.694958726869;6787.660616969132;6800.625965571891;6706.061151438803;6786.864262714718;6860.485463590251;6876.724931002754;6891.965540172267;6283.183186185766;6285.685715714288;6295.464885484694;6331.810045698637;6350.396712312323;6661.766838160641;6812.523123381415;6984.092068031225;6986.056882320923;6994.195667498303;6551.213854337415;6567.179102612174;6587.077809106729;6599.47204223661;6682.198136223684;6776.322367763283;6863.897041544381;6865.794026179223;6869.347411995853;6892.551984121116;6829.863402731918;6832.145981752281;6833.214180369222;6838.48711346651;6850.4862135340045;6659.500537459709;6679.131712877392;6745.460363170934;6759.763408280686;6782.457403407716;5111.386633603991;5121.795128194905;5130.410002849645;5131.999260144236;5132.307138536325;4482.596566308983;4517.34498497716;4517.412736344254;4518.728876267434;4538.931916021263;6432.774852880127;6463.385978332051;6465.967670161619;6473.22321321435;6483.740650374027;6600.636964966877;6733.158355205599;6887.965560172167;6910.861782764317;6919.861602767916;6318.8420289492215;6352.968235158794;6422.967885160544;6432.742690292336;6443.742250310029;5701.686407247641;5708.372079071299;5718.68547229898;5736.856578585569;5739.196512488255;7150;7151.2133665297815;7155.606441645656;7157.141143062866;7195.02867112954;6666.433353164842;6853.451723862178;6860.416864566568;6862.348076932683;6863.759768408082;7047.330503602149;7105.786826395217;7146;7153.213146553979;7193.496455248082;6676.1988561371;6735.4274886635185;6746.123004009643;6751.426128778912;6771.221309549464;6847.315268473312;6888.827779305357;6900.482463815334;6902.344277293649;6905.413039891666;6539.378759017885;6648.601083934979;6656.201255849329;6666.733330666719;6681.09805176295;6511.609303441809;6581.80254592363;6625.238097618835;6638.17022872141;6690.063391125149;6526.412622863965;6599.406053455212;6604.207495100619;6606.405423511907;6664;6616.503762217949;6634.767783127568;6639.170103737033;6709.228438729413;6735.6968936397;6417.96791016042;6436.549441539048;6455.677216139268;6498.967505162444;6506.154199953976 05:55:47 INFO - PID 3574 | |1;ext.html;883.8364902493039;903.2232280238998;944.1879983214435;957.5738796235678;971.5385192033781;40859.59140408595;41681;41886.79056604713;41952;41960.370594441105;37394.8130259349;37721.62278377215;37735.05662358442;37860.43209351862;37891.621083789156;6739.157605299325;6753.223379311393;6773;6816.795496135124;6823.795286141423;6673.49948753843;6673.799786006428;6759.256481787;6764.729410823561;6789.3889549940495;6716.0933274007875;6729.7644582439625;6758.0538724578355;6760.898586521206;6789.049533065375;6734.19189697237;6748.325167483262;6754.223264324616;6785.050092986986;6797.490188235902;6216.937830621727;6247.2815626202655;6253.1245625612455;6258.43674069336;6259.467945224661;34540.309193815985;34660.30679386398;34773.826130869435;34785;34818.651813481796;3410.5907291124977;3431.6225215226304;3439.1402149462633;3520.7887526748477;3598.6941110005682;30619.693803061906;30619.69380306213;30929;31097.68902310993;31099;3672.7796332219887;3780.319542482352;3804.9429258561145;3807.3717836556934;3854.402567602026;191848;194770;195376.02311988492;200962;202070;47910.520894791305;48525.27212091821;48791;48968;49299.27452539144;50623.493765062616;50886.491135088916;51011.23483147756;51117.48882511127;51302.230466543035;15424.922875385551;15449.768253476206;15598.142102184489;15632.3747050119;15697.372105115895;12857.935710321575;12868.613941581767;12870.841624253862;12876.291803950873;12896.80654790179;13613.387397567134;13703.794443083361;13714.657133571542;13809.930950345184;13950.581482555337;5557.722113894289;5599.80400685974;5641.971790141023;5704.80033198836;5795.913061304083;1066.6373433032807;1091.247039542713;1104.6023431564631;1112.265904503024;1118.8769235384102;24021.51956960851;24676.629850552257;25310;25395.61906571403;25595.48809023809;1207.5954555224098;1214.9817752733716;1218.1594699657207;1219.951201951912;1230.1450491908217;13396;13425.932870335586;13438.849784034703;13514.459421623025;13645;268772;269388;269510;269794;270573;51320.74339628278;51787.74106129521;51922.740386297824;51999.74000129975;52222.47777522176;1447.1027962663215;1525.3212320517264;1526.381815364779;1528.7859699642058;1542.5603702944832;24104;29844.70155298506;30571;30617.846910765304;30941.381172376878;50909.23636145387;50968.49031509637;51317;51400.74299628478;51424.48575514197;244927;245760;246820;246997;248401;31569.684303156675;32241.51637725483;32264.83867580647;35494.46758298576;35582.28835423225;39517.80241098776;41505.58494415017;42032.1593568133;42594.148117036864;44011.33982990322;30133.09600711982;30550.388992219585;30801.537976929914;31812.8409357961;32504.187395315308;30682.84658576693;31149;31717.524237136;31823.681763182998;32365.35269294648;36522.817385913964;36723.08192295214;37658.43512347372;37806.43290350702;38129.04677383087;31590.684093159693;32429.837850810596;32756.672433275362;32766.344673105927;33526.83236583802;25100.62349064802;26663.600045999712;27039.86480067587;27066.729332707208;27435.725642743317 05:55:47 INFO - PID 3574 | |2;jquery.html;562.8339639806256;568.897598432282;570.1020892094951;583.3408248678993;591.7366771786554;21995.670064949038;22739.54520909581;22827.657585136236;22887.542249155005;22903;24487.75512244877;26019.349516262104;27260.72739272607;27304.180874573743;27487.587686184725;6229.875402491947;6289.968550157243;6337.397947195032;6337.461315788163;6338.904916426257;6234.314225435199;6294;6300;6320.715567799437;6340.461060809814;5777.566682498808;6093.451589356957;6099.756009759604;6280.183576135096;6299.496040316787;6080.726367313481;6139.815805525842;6168.87662246757;6170.81487555374;6177.7837775677635;5762.769489220468;5763.942360576382;5768.913466298009;5769.740361683735;5779.682117483537;27988;29241.85379073091;29421.11736647904;29428.411431771245;29481.852590737122;2252.8986195621073;2332.661764044221;2349.283468542094;2353.188150088217;2355.0815182079004;18444.262229510936;18984.5253868653;19080;19208.903955480273;19246.230150793952;2296.666983287414;2344.1561038026466;2384.1536254629705;2385.403649087728;2395.5089206712582;129691;131715;131986;132040.33979830134;132117;14401;15192.164430956182;15403.537893863202;15454.768178477332;15604;23082.192123275603;23237.53524929492;23345.299641010795;23368.64947025796;23473.647895281585;10063.792344918656;10200.132988695896;10291.742706432398;10293.125084367763;10388.11701005423;9303.302252331103;9441.15029647335;9465.242780577537;9474.810503790024;9493.19307858826;9403.200727938201;9428.481433521221;9586.555428365722;9754.414735115774;9810.16613587853;2733.248356701883;2740.5478096113916;2795.3011747063233;2843.3886714356513;3004.2339203502966;1053.6048981631889;1055.6516349604613;1080.2654195147375;1085.8968398002178;1095.742500512379;20426.69359959602;23924.52150957006;25854;26241.475170496866;26524.867375662998;1111.1222134513644;1129.9830502542468;1136.1478890831877;1139.9886001140048;1142.5087212498706;12067.215630983957;12213.45039473226;12278.447469863877;12281.93859030699;12300.938495307646;585174;609688;614756;626249;653029;117200.41399793117;119508.4024579889;120695;122826;123967;1272.1603741530546;1314.0473156961127;1326.8673132686654;1335.6126723250343;1337.0840973932886;17823.197956092266;19111.13999870037;19112.61774764469;19119;19407.8059219406;53310;54416;54725.72637136789;55403.72298138483;55967.16049259183;69320.6533967327;69543.3045669557;69875.30124698688;71470;71557.64221178861;11810.645680629596;12432.254064756144;12498.312592807482;12515.374231288217;12624;18471.722924155878;18809;18867.15097820629;19686.212551497778;19813.10841012129;15604.375824966874;16054.598635034217;16126.758098628765;16305.510834674978;16548.834511654728;13961.371738271599;14595.416183352972;14874.851251487347;14998.625034374229;15136.318865651292;16720.665586687956;16743.24655390486;16757.32970681159;16764.74852877232;16778;12526.311052892179;13105.475780968654;13170.407331669907;13235.933820330836;13304.201747894771;15563.610909727347;15666.843331566994;15828;15879.603009924844;16373.42693005739 05:55:47 INFO - PID 3574 | |3;mootools.html;1458.8978771485997;1521.7869498270238;1522.8477152284772;1547.9767803482944;1554.992225038875;14703.70592588149;15247.161406122672;15252.237388130605;15278;15335.38658453662;14567.271636418163;15548.611284717888;15624.140672263049;15643.296051677673;15665;2723.6050772637955;2742.520058989679;2750.6286651302116;2762.3646561290816;2767.0730305347633;2588.5211235921415;2670.572708366652;2670.9599356009676;2674.1175412113957;2688.9596656050176;2547.2867597072755;2559.436923876744;2563.794896408292;2606.817522773407;2613.7647611714942;2650.3109191610224;2761.4615150045647;2761.4753196892625;2774.6254255675426;2777.847218402987;2556.3864672478658;2576.0854896511655;2587.2496975876975;2601.375669839244;2614.73852614737;14494.42022319106;14774.778378324334;14790.334434950346;14848.2575871206;14888.702225955529;8154.836903261961;8398.03422606402;8400.915990840074;8433.241008309282;8443.788905277417;4724.952750472486;4751.9143522408185;4827.493113223131;4879.536444037811;4895.6083513318845;1625.8049034115863;1632.648980469193;1644.4162322375623;1664.8751343649153;1670.5573023148754;23974.760252397427;24024.879875600684;24038.87980560086;24071.277861664177;24148.39629009271;6843.657817109125;6855.348741869514;6910.101686780687;6957.408620267232;7034.2262351141335;16724.331026758795;16863.409780657617;16906.915465422593;17014.404495842587;17082.23129959155;8065.153158918229;8182.059063207688;8222.054463736747;8239.794005149919;8241.969753780777;7542.47202695817;7554.093508778872;7634.198409166957;7668.079830420385;7779.222077792176;5269;5383.380911195262;5432.511074003359;5432.891342173213;5677.034904066319;1580.2888700085007;1598.3686443854613;1599.7920270364777;1614.5398561410177;1619.40082169598;923.1138107416821;927.0960813207204;938.9906100938903;971.2715463402449;977.9853302200472;7695.345895598937;7799.986001819727;7820.569868657279;7980.241877021674;8018.238267364591;726.1721637333444;743.2530307041388;750.8474491655282;764.9388048956071;772.4785769605494;4926.433460152129;5200.067701436722;5277.419483856773;5406.91889621656;5600.52395546375;19637.901810490857;20381.286654967003;20404.18383264653;20529.589408211752;20543.28098516545;19888.204471821253;20102.296419625243;20813.791862081187;20884.582308354053;20896.47758806042;11255.718607034889;11376.488058037243;11385.715357115972;11399.259048161843;11515.539378424937;7890.210978902293;8353.289970352587;8578.957105214435;8688.565571721263;8711.21599056088;17231.310747569958;17387.652246954738;17943;18135;18177.636447271245;17662.293508260038;18661.253549857855;18663.813361866207;18841.90579047096;19019;11123.833142502706;11320;11341.752407235033;11359;11366.829497557377;13630.1140425872;13732.519361822287;13756;13784.448622055406;13831.30843457803;10680.145588353069;10689.465526723478;11086.889131108586;11135;11566.074714023027;10616.84074738895;10756.193285503776;10922;10933.671989840317;11004.779904402027;9974.850377244202;10147.391156530632;10152.644657436955;10155.593776248867;10159.949200253952;7111.43108551325;7153.964230179024;7251.274872512707;7266.237045110187;7428.702851885864;6649.800505984828;6849.965750171217;6932.549384290005;6990;7012.263712310134 05:55:47 INFO - PID 3574 | |4;prototype.html;507.87049302427874;518.548862489634;521.6817741177882;532.4489153725895;538.8733647592815;6109.908351374727;6177;6216.07301736462;6230.750769969196;6263.091851681509;6108.205933228674;6136.294326152494;6155.276522573676;6157.7536898524;6172.475339596129;4905.092557876796;4916.483769204236;4927.531884470987;4936.80252789888;4954.1330267203275;4946.134426475371;4949.257611358289;4953.678010929296;4957.851264462054;4967.950320496785;4925.26121081837;4943.505649435064;4947.752612369385;4951.678140920847;4958.479359667237;4938.82691615688;4941.382327209099;4944.456109827898;4950.3069570260195;4963.875903102416;4185.455890734185;4345.304751239818;4358.237308471005;4579.542045795427;4580.290055041474;6001.5198784097165;6007.128966299862;6027.668478233695;6031.306399764039;6040.5469589780505;5725.797582507678;5752.942470575283;5762.827115186551;5766.826995190109;5787.33445653751;6552;6562.901556476657;6594.571352862049;6599.030436303682;6647.268800431949;4894.36373271476;4901.65688401812;4906.239532872411;4918.680285781448;4936.80252789888;6662.800115996528;6819.215790184093;6847.726090956356;6881.690323935435;6912.965435172792;4864.513548645178;4967.552920237196;5004.649674522821;5054.241863720398;5081.415637201695;5134.435212126663;5135.35808023997;5147.176451767699;5155.278261043457;5164.48355164488;5638.802641907513;5667.886642267132;5674.865026994535;5703.230063941398;5723.599348045597;6551.213854337415;6568.868622627616;6576.408123268929;6581.2760596334365;6613.933860661428;1773.2906837265198;1800.297883825309;1800.324878170686;1805.386168702621;1806.5935164588125;1183.7691650128315;1249.5938819883575;1261.6215135459327;1274.120856608937;1280.9743805124033;6162.812201668433;6227.377262273827;6264.373562643699;6285.874282514415;6290.056491526308;6639.966800166065;6733.225679046972;6736.225334086643;6748.190217173872;6769.796906092825;6120.908186377208;6166.660833654102;6174.5060395168275;6193.535484838655;6312.621242725451;3582.2656355447593;3582.3014512169875;3585.7629117954266;3595.7482976191413;3605;7027.5080744348425;7028.92971070293;7037.577745335297;7067.646617669096;7085.14978202619;6928.653567321614;6945.513814032969;6949.166100067923;6978.581285122909;6996.230414654384;6474.579152355176;6960.804883653553;7020.824479387954;7066.470014748915;7088.681009354591;6654.068430419648;6670.299618540177;6696.296888826798;6715.932840671726;6751.189857217166;6570;6675.499337549801;6702.932970670426;6706.631135287606;6709.8257804884925;7007.194172670208;7049;7063.187733410724;7078.929210707827;7082.433405327664;5024.120778863758;5040.243963405372;5054.963732434916;5083.881546059861;5092.159793634009;6524.575902566318;6642.070110184674;6685.498587605852;6740.797776066725;6770.763023294358;6258.217722784652;6536.901946470902;6545.574537655038;6591.637459939558;6606.702698378681;6532.738690452328;6557.344265573595;6558.376954189344;6576.868462630816;6591.571547849375;6519.282878883414;6523.347665233438;6530.47756179495;6542.803715888341;6574.737010519526;6544.738210471528;6594.505412094208;6600.306967768315;6606.4384527315715;6621.900671489835;6393.1688880445245;6403.391677790602;6423.29343772194;6442.09810626522;6455.548111632141 05:55:47 INFO - PID 3574 | |5;yui.html;878.7100256915214;899.5367385796312;915.0483497162951;915.199200699388;919.2829592917525;17703.911480442595;17946.012969286683;18084.734068615202;18110.909445452788;18128.4561463156;17263.30946762128;17264;17277.913610431962;17734.645307093884;19356.903215483904;1073.1468482556386;1084.7559299157706;1086.3156211586688;1087.836824476331;1091.8908109189097;1066.1524088349781;1075.2741899218036;1075.6074032977947;1080.4543705428748;1080.6541906589894;1139.128566646516;1139.800534906388;1143.1883362812414;1144.3934714601276;1145.7880292145937;1066.1311031509294;1105.6296140792845;1138.231693606812;1144.342003348074;1148.8104462763633;808.4098608016122;808.6846130009242;810.4488947515687;811.4806523824698;815.9510429374197;17230.827691723047;17297.740533892003;17390.913045434692;17427.39004134849;17448.38930637434;17182.398616048504;18144.09279536031;18192.818071819245;18236;18281.360152394736;12803.295818729966;12945;13158.671033224246;13270.402831872589;13310.334483275894;3519.9120021999397;3533.222691007974;3542.256126213498;3560.946585801215;3564.803935783531;112063.43968280106;114351.42824285908;115336;116682;117595.82404175935;13852.584422467342;13994.440222391195;14406.279686015658;14614.34235459407;14681.77977330341;29344.972925947488;29551.113466596038;29621.407571848442;29893.850530747208;30002.24994375158;8230.176982301722;8457.619407126695;8485.40602157843;8507.149285071568;8552.358573107042;3985.8604948827233;4032.6169013943627;4058.3912413137673;4060.045889216032;4072.511298644182;4782.163121453732;5093.898122037613;5142.485751424828;5195.558377537876;5303.443138470482;1014.3710899242517;1040.9115225205792;1052.85786418834;1062.1396668698378;1071.0360675392053;718.60476737794;734.1923883727964;737.2664199121801;752.7779305105007;759.8822182561712;12161.513539458323;12390.81413778794;12531.686707832196;12730.9363453184;13080.803787943189;731.7950973727259;732.571445704269;736.977890663281;741.2550386861278;752.1575835064654;5758.74085666146;5789.797357092481;5885.882282354414;5957.731902064417;6027.7287522061615;111216;112169;112657.4367128159;113734;116678.41660791641;100808;102457;104923.4753826226;107100.464497677;107225.46387268169;86800;90004;90220;92737;93740;11338.14963877696;11934.403279836148;12003.939980300043;12095.39523023863;12309.199902006341;42808.57191428046;44113;44740;45971.3104303429;47101;54074;55216.21450889563;55362.44637553573;56032.71983640056;56557.71721141368;15600.453984110502;15902.284397202386;16262;16297;16493.09287989172;16022.919885400499;17037.14814259307;17182.570435739206;17200.31198752086;17310.394136205174;16643.583910402336;16754.329826806792;16757.1621418931;16891;16926.746098808773;14092.718145637235;14418.567442976728;14435.2060636666;14505.637359066108;14770.039947403384;14730.926345368205;14900.403983840524;15418.614534636723;15808.841911580737;15931.442399515961;12128.75742485163;12132.575359862363;12212.816807747713;12335.75328493443;13060;12693.682657933256;12775.744485110059;12886.548970785978;12887.226766394046;13173.60479185626 05:55:47 INFO - PID 3574 | __end_tp_report 05:55:47 INFO - PID 3574 | __start_cc_report 05:55:47 INFO - PID 3574 | _x_x_mozilla_cycle_collect,325 05:55:47 INFO - PID 3574 | __end_cc_report 05:55:47 INFO - PID 3574 | __startTimestamp1498481747933__endTimestamp 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | ------- Summary: start ------- 05:55:47 INFO - PID 3574 | Number of tests: 6 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | [#0] dojo.html Cycles:165 Average:6253.78 Median:6539.38 stddev:797.62 (12.2%) stddev-sans-first:766.86 05:55:47 INFO - PID 3574 | Values: 3350.7 3412.9 3418.5 3433.6 3449.6 6169.7 6202.3 6203.6 6208.3 6230.7 6269.8 6271.2 6298.6 6315.7 6345.4 5507.1 5514.7 5527.9 5544.9 5631.7 5541.8 5552.0 5568.5 5593.6 5602.3 5449.9 5496.8 5505.8 5532.5 5593.5 5478.0 5488.9 5547.6 5554.4 5562.6 5459.7 5516.4 5523.0 5535.9 5553.2 6223.6 6244.3 6259.1 6272.3 6274.2 6622.7 6747.6 6778.7 6787.7 6800.6 6706.1 6786.9 6860.5 6876.7 6892.0 6283.2 6285.7 6295.5 6331.8 6350.4 6661.8 6812.5 6984.1 6986.1 6994.2 6551.2 6567.2 6587.1 6599.5 6682.2 6776.3 6863.9 6865.8 6869.3 6892.6 6829.9 6832.1 6833.2 6838.5 6850.5 6659.5 6679.1 6745.5 6759.8 6782.5 5111.4 5121.8 5130.4 5132.0 5132.3 4482.6 4517.3 4517.4 4518.7 4538.9 6432.8 6463.4 6466.0 6473.2 6483.7 6600.6 6733.2 6888.0 6910.9 6919.9 6318.8 6353.0 6423.0 6432.7 6443.7 5701.7 5708.4 5718.7 5736.9 5739.2 7150.0 7151.2 7155.6 7157.1 7195.0 6666.4 6853.5 6860.4 6862.3 6863.8 7047.3 7105.8 7146.0 7153.2 7193.5 6676.2 6735.4 6746.1 6751.4 6771.2 6847.3 6888.8 6900.5 6902.3 6905.4 6539.4 6648.6 6656.2 6666.7 6681.1 6511.6 6581.8 6625.2 6638.2 6690.1 6526.4 6599.4 6604.2 6606.4 6664.0 6616.5 6634.8 6639.2 6709.2 6735.7 6418.0 6436.5 6455.7 6499.0 6506.2 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | [#1] ext.html Cycles:180 Average:40457.83 Median:18989.72 stddev:62437.28 (328.8%) stddev-sans-first:62541.73 05:55:47 INFO - PID 3574 | Values: 883.8 903.2 944.2 957.6 971.5 40859.6 41681.0 41886.8 41952.0 41960.4 37394.8 37721.6 37735.1 37860.4 37891.6 6739.2 6753.2 6773.0 6816.8 6823.8 6673.5 6673.8 6759.3 6764.7 6789.4 6716.1 6729.8 6758.1 6760.9 6789.0 6734.2 6748.3 6754.2 6785.1 6797.5 6216.9 6247.3 6253.1 6258.4 6259.5 34540.3 34660.3 34773.8 34785.0 34818.7 3410.6 3431.6 3439.1 3520.8 3598.7 30619.7 30619.7 30929.0 31097.7 31099.0 3672.8 3780.3 3804.9 3807.4 3854.4 191848.0 194770.0 195376.0 200962.0 202070.0 47910.5 48525.3 48791.0 48968.0 49299.3 50623.5 50886.5 51011.2 51117.5 51302.2 15424.9 15449.8 15598.1 15632.4 15697.4 12857.9 12868.6 12870.8 12876.3 12896.8 13613.4 13703.8 13714.7 13809.9 13950.6 5557.7 5599.8 5642.0 5704.8 5795.9 1066.6 1091.2 1104.6 1112.3 1118.9 24021.5 24676.6 25310.0 25395.6 25595.5 1207.6 1215.0 1218.2 1220.0 1230.1 13396.0 13425.9 13438.8 13514.5 13645.0 268772.0 269388.0 269510.0 269794.0 270573.0 51320.7 51787.7 51922.7 51999.7 52222.5 1447.1 1525.3 1526.4 1528.8 1542.6 24104.0 29844.7 30571.0 30617.8 30941.4 50909.2 50968.5 51317.0 51400.7 51424.5 244927.0 245760.0 246820.0 246997.0 248401.0 31569.7 32241.5 32264.8 35494.5 35582.3 39517.8 41505.6 42032.2 42594.1 44011.3 30133.1 30550.4 30801.5 31812.8 32504.2 30682.8 31149.0 31717.5 31823.7 32365.4 36522.8 36723.1 37658.4 37806.4 38129.0 31590.7 32429.8 32756.7 32766.3 33526.8 25100.6 26663.6 27039.9 27066.7 27435.7 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | [#2] jquery.html Cycles:180 Average:37953.81 Median:22895.27 stddev:102572.24 (448.0%) stddev-sans-first:102821.56 05:55:47 INFO - PID 3574 | Values: 562.8 568.9 570.1 583.3 591.7 21995.7 22739.5 22827.7 22887.5 22903.0 24487.8 26019.3 27260.7 27304.2 27487.6 6229.9 6290.0 6337.4 6337.5 6338.9 6234.3 6294.0 6300.0 6320.7 6340.5 5777.6 6093.5 6099.8 6280.2 6299.5 6080.7 6139.8 6168.9 6170.8 6177.8 5762.8 5763.9 5768.9 5769.7 5779.7 27988.0 29241.9 29421.1 29428.4 29481.9 2252.9 2332.7 2349.3 2353.2 2355.1 18444.3 18984.5 19080.0 19208.9 19246.2 2296.7 2344.2 2384.2 2385.4 2395.5 129691.0 131715.0 131986.0 132040.3 132117.0 14401.0 15192.2 15403.5 15454.8 15604.0 23082.2 23237.5 23345.3 23368.6 23473.6 10063.8 10200.1 10291.7 10293.1 10388.1 9303.3 9441.2 9465.2 9474.8 9493.2 9403.2 9428.5 9586.6 9754.4 9810.2 2733.2 2740.5 2795.3 2843.4 3004.2 1053.6 1055.7 1080.3 1085.9 1095.7 20426.7 23924.5 25854.0 26241.5 26524.9 1111.1 1130.0 1136.1 1140.0 1142.5 12067.2 12213.5 12278.4 12281.9 12300.9 585174.0 609688.0 614756.0 626249.0 653029.0 117200.4 119508.4 120695.0 122826.0 123967.0 1272.2 1314.0 1326.9 1335.6 1337.1 17823.2 19111.1 19112.6 19119.0 19407.8 53310.0 54416.0 54725.7 55403.7 55967.2 69320.7 69543.3 69875.3 71470.0 71557.6 11810.6 12432.3 12498.3 12515.4 12624.0 18471.7 18809.0 18867.2 19686.2 19813.1 15604.4 16054.6 16126.8 16305.5 16548.8 13961.4 14595.4 14874.9 14998.6 15136.3 16720.7 16743.2 16757.3 16764.7 16778.0 12526.3 13105.5 13170.4 13235.9 13304.2 15563.6 15666.8 15828.0 15879.6 16373.4 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | [#3] mootools.html Cycles:180 Average:9132.50 Median:2557.91 stddev:6324.96 (247.3%) stddev-sans-first:6316.42 05:55:47 INFO - PID 3574 | Values: 1458.9 1521.8 1522.8 1548.0 1555.0 14703.7 15247.2 15252.2 15278.0 15335.4 14567.3 15548.6 15624.1 15643.3 15665.0 2723.6 2742.5 2750.6 2762.4 2767.1 2588.5 2670.6 2671.0 2674.1 2689.0 2547.3 2559.4 2563.8 2606.8 2613.8 2650.3 2761.5 2761.5 2774.6 2777.8 2556.4 2576.1 2587.2 2601.4 2614.7 14494.4 14774.8 14790.3 14848.3 14888.7 8154.8 8398.0 8400.9 8433.2 8443.8 4725.0 4751.9 4827.5 4879.5 4895.6 1625.8 1632.6 1644.4 1664.9 1670.6 23974.8 24024.9 24038.9 24071.3 24148.4 6843.7 6855.3 6910.1 6957.4 7034.2 16724.3 16863.4 16906.9 17014.4 17082.2 8065.2 8182.1 8222.1 8239.8 8242.0 7542.5 7554.1 7634.2 7668.1 7779.2 5269.0 5383.4 5432.5 5432.9 5677.0 1580.3 1598.4 1599.8 1614.5 1619.4 923.1 927.1 939.0 971.3 978.0 7695.3 7800.0 7820.6 7980.2 8018.2 726.2 743.3 750.8 764.9 772.5 4926.4 5200.1 5277.4 5406.9 5600.5 19637.9 20381.3 20404.2 20529.6 20543.3 19888.2 20102.3 20813.8 20884.6 20896.5 11255.7 11376.5 11385.7 11399.3 11515.5 7890.2 8353.3 8579.0 8688.6 8711.2 17231.3 17387.7 17943.0 18135.0 18177.6 17662.3 18661.3 18663.8 18841.9 19019.0 11123.8 11320.0 11341.8 11359.0 11366.8 13630.1 13732.5 13756.0 13784.4 13831.3 10680.1 10689.5 11086.9 11135.0 11566.1 10616.8 10756.2 10922.0 10933.7 11004.8 9974.9 10147.4 10152.6 10155.6 10159.9 7111.4 7154.0 7251.3 7266.2 7428.7 6649.8 6850.0 6932.5 6990.0 7012.3 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | [#4] prototype.html Cycles:180 Average:5585.67 Median:6185.27 stddev:1583.46 (25.6%) stddev-sans-first:1541.35 05:55:47 INFO - PID 3574 | Values: 507.9 518.5 521.7 532.4 538.9 6109.9 6177.0 6216.1 6230.8 6263.1 6108.2 6136.3 6155.3 6157.8 6172.5 4905.1 4916.5 4927.5 4936.8 4954.1 4946.1 4949.3 4953.7 4957.9 4968.0 4925.3 4943.5 4947.8 4951.7 4958.5 4938.8 4941.4 4944.5 4950.3 4963.9 4185.5 4345.3 4358.2 4579.5 4580.3 6001.5 6007.1 6027.7 6031.3 6040.5 5725.8 5752.9 5762.8 5766.8 5787.3 6552.0 6562.9 6594.6 6599.0 6647.3 4894.4 4901.7 4906.2 4918.7 4936.8 6662.8 6819.2 6847.7 6881.7 6913.0 4864.5 4967.6 5004.6 5054.2 5081.4 5134.4 5135.4 5147.2 5155.3 5164.5 5638.8 5667.9 5674.9 5703.2 5723.6 6551.2 6568.9 6576.4 6581.3 6613.9 1773.3 1800.3 1800.3 1805.4 1806.6 1183.8 1249.6 1261.6 1274.1 1281.0 6162.8 6227.4 6264.4 6285.9 6290.1 6640.0 6733.2 6736.2 6748.2 6769.8 6120.9 6166.7 6174.5 6193.5 6312.6 3582.3 3582.3 3585.8 3595.7 3605.0 7027.5 7028.9 7037.6 7067.6 7085.1 6928.7 6945.5 6949.2 6978.6 6996.2 6474.6 6960.8 7020.8 7066.5 7088.7 6654.1 6670.3 6696.3 6715.9 6751.2 6570.0 6675.5 6702.9 6706.6 6709.8 7007.2 7049.0 7063.2 7078.9 7082.4 5024.1 5040.2 5055.0 5083.9 5092.2 6524.6 6642.1 6685.5 6740.8 6770.8 6258.2 6536.9 6545.6 6591.6 6606.7 6532.7 6557.3 6558.4 6576.9 6591.6 6519.3 6523.3 6530.5 6542.8 6574.7 6544.7 6594.5 6600.3 6606.4 6621.9 6393.2 6403.4 6423.3 6442.1 6455.5 05:55:47 INFO - PID 3574 | 05:55:47 INFO - PID 3574 | [#5] yui.html Cycles:180 Average:22706.81 Median:16981.95 stddev:31885.76 (187.8%) stddev-sans-first:31933.08 05:55:47 INFO - PID 3574 | Values: 878.7 899.5 915.0 915.2 919.3 17703.9 17946.0 18084.7 18110.9 18128.5 17263.3 17264.0 17277.9 17734.6 19356.9 1073.1 1084.8 1086.3 1087.8 1091.9 1066.2 1075.3 1075.6 1080.5 1080.7 1139.1 1139.8 1143.2 1144.4 1145.8 1066.1 1105.6 1138.2 1144.3 1148.8 808.4 808.7 810.4 811.5 816.0 17230.8 17297.7 17390.9 17427.4 17448.4 17182.4 18144.1 18192.8 18236.0 18281.4 12803.3 12945.0 13158.7 13270.4 13310.3 3519.9 3533.2 3542.3 3560.9 3564.8 112063.4 114351.4 115336.0 116682.0 117595.8 13852.6 13994.4 14406.3 14614.3 14681.8 29345.0 29551.1 29621.4 29893.9 30002.2 8230.2 8457.6 8485.4 8507.1 8552.4 3985.9 4032.6 4058.4 4060.0 4072.5 4782.2 5093.9 5142.5 5195.6 5303.4 1014.4 1040.9 1052.9 1062.1 1071.0 718.6 734.2 737.3 752.8 759.9 12161.5 12390.8 12531.7 12730.9 13080.8 731.8 732.6 737.0 741.3 752.2 5758.7 5789.8 5885.9 5957.7 6027.7 111216.0 112169.0 112657.4 113734.0 116678.4 100808.0 102457.0 104923.5 107100.5 107225.5 86800.0 90004.0 90220.0 92737.0 93740.0 11338.1 11934.4 12003.9 12095.4 12309.2 42808.6 44113.0 44740.0 45971.3 47101.0 54074.0 55216.2 55362.4 56032.7 56557.7 15600.5 15902.3 16262.0 16297.0 16493.1 16022.9 17037.1 17182.6 17200.3 17310.4 16643.6 16754.3 16757.2 16891.0 16926.7 14092.7 14418.6 14435.2 14505.6 14770.0 14730.9 14900.4 15418.6 15808.8 15931.4 12128.8 12132.6 12212.8 12335.8 13060.0 12693.7 12775.7 12886.5 12887.2 13173.6 05:55:47 INFO - PID 3574 | -------- Summary: end -------- 05:55:47 INFO - PID 3574 | 05:55:48 INFO - TEST-INFO | 3574: exit 0 05:55:48 INFO - TEST-OK | dromaeo_css | took 1117596ms 05:55:48 INFO - TEST-START | kraken 05:55:48 INFO - operating with platform_type : linux_ 05:55:48 INFO - Initialising browser for kraken test... 05:55:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50320/getInfo.html -profile /tmp/tmpdBNjII/profile 05:55:48 INFO - TEST-INFO | started process 3989 (/builds/slave/test/build/application/firefox/firefox http://localhost:50320/getInfo.html) 05:55:54 INFO - TEST-INFO | 3989: exit 0 05:55:54 INFO - Browser initialized. 05:55:54 INFO - Running cycle 1/1 for kraken test... 05:55:54 INFO - TEST-INFO | started process 4199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdBNjII/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:05 INFO - PID 4199 | RSS: Main: 162922496 05:56:05 INFO - PID 4199 | 05:56:07 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50320/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:08 INFO - PID 4199 | RSS: Main: 167280640 05:56:08 INFO - PID 4199 | 05:56:11 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50320/tests/kraken/driver.html?testName=audio-dft) 05:56:12 INFO - PID 4199 | RSS: Main: 167387136 05:56:12 INFO - PID 4199 | 05:56:14 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50320/tests/kraken/driver.html?testName=audio-fft) 05:56:15 INFO - PID 4199 | RSS: Main: 162054144 05:56:15 INFO - PID 4199 | 05:56:17 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50320/tests/kraken/driver.html?testName=audio-oscillator) 05:56:18 INFO - PID 4199 | RSS: Main: 164065280 05:56:18 INFO - PID 4199 | 05:56:20 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:56:20 INFO - PID 4199 | RSS: Main: 162926592 05:56:20 INFO - PID 4199 | 05:56:23 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50320/tests/kraken/driver.html?testName=imaging-darkroom) 05:56:24 INFO - PID 4199 | RSS: Main: 163844096 05:56:24 INFO - PID 4199 | 05:56:27 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50320/tests/kraken/driver.html?testName=imaging-desaturate) 05:56:28 INFO - PID 4199 | RSS: Main: 167116800 05:56:28 INFO - PID 4199 | 05:56:31 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50320/tests/kraken/driver.html?testName=json-parse-financial) 05:56:31 INFO - PID 4199 | RSS: Main: 167129088 05:56:31 INFO - PID 4199 | 05:56:33 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:56:33 INFO - PID 4199 | RSS: Main: 166797312 05:56:33 INFO - PID 4199 | 05:56:35 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:56:36 INFO - PID 4199 | RSS: Main: 167145472 05:56:36 INFO - PID 4199 | 05:56:38 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:56:38 INFO - PID 4199 | RSS: Main: 167239680 05:56:38 INFO - PID 4199 | 05:56:41 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:56:42 INFO - PID 4199 | RSS: Main: 166858752 05:56:42 INFO - PID 4199 | 05:56:44 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:45 INFO - PID 4199 | RSS: Main: 166965248 05:56:45 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | Cycle 1(1): loaded http://localhost:50320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50320/tests/kraken/driver.html?testName=ai-astar) 05:56:47 INFO - PID 4199 | RSS: Main: 169193472 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | __start_tp_report 05:56:47 INFO - PID 4199 | _x_x_mozilla_page_load 05:56:47 INFO - PID 4199 | _x_x_mozilla_page_load_details 05:56:47 INFO - PID 4199 | |i|pagename|runs| 05:56:47 INFO - PID 4199 | |0;ai-astar;98;106;108;105;106;108;108;109;106;108 05:56:47 INFO - PID 4199 | |1;audio-beat-detection;143;115;151;167;117;144;148;115;173;123 05:56:47 INFO - PID 4199 | |2;audio-dft;163;163;162;161;162;169;162;160;165;166 05:56:47 INFO - PID 4199 | |3;audio-fft;73;76;74;154;77;73;71;73;91;74 05:56:47 INFO - PID 4199 | |4;audio-oscillator;82;81;132;80;80;82;138;81;81;141 05:56:47 INFO - PID 4199 | |5;imaging-gaussian-blur;113;114;113;113;113;114;113;113;113;113 05:56:47 INFO - PID 4199 | |6;imaging-darkroom;146;147;146;147;148;147;147;148;147;149 05:56:47 INFO - PID 4199 | |7;imaging-desaturate;95;95;94;94;95;94;94;94;96;94 05:56:47 INFO - PID 4199 | |8;json-parse-financial;49;49;49;46;49;47;46;46;47;46 05:56:47 INFO - PID 4199 | |9;json-stringify-tinderbox;54;53;52;52;54;54;53;53;53;53 05:56:47 INFO - PID 4199 | |10;stanford-crypto-aes;76;74;74;74;73;74;74;73;74;76 05:56:47 INFO - PID 4199 | |11;stanford-crypto-ccm;122;120;120;122;120;121;127;120;125;157 05:56:47 INFO - PID 4199 | |12;stanford-crypto-pbkdf2;178;177;172;175;170;171;175;182;173;171 05:56:47 INFO - PID 4199 | |13;stanford-crypto-sha256-iterative;62;64;61;60;62;60;60;59;59;59 05:56:47 INFO - PID 4199 | __end_tp_report 05:56:47 INFO - PID 4199 | __start_cc_report 05:56:47 INFO - PID 4199 | _x_x_mozilla_cycle_collect,836 05:56:47 INFO - PID 4199 | __end_cc_report 05:56:47 INFO - PID 4199 | __startTimestamp1498481807451__endTimestamp 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | ------- Summary: start ------- 05:56:47 INFO - PID 4199 | Number of tests: 14 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#0] ai-astar Cycles:10 Average:106.20 Median:108.00 stddev:3.16 (2.9%) stddev-sans-first:1.36 05:56:47 INFO - PID 4199 | Values: 98.0 106.0 108.0 105.0 106.0 108.0 108.0 109.0 106.0 108.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:146.00 stddev:21.33 (14.6%) stddev-sans-first:22.59 05:56:47 INFO - PID 4199 | Values: 143.0 115.0 151.0 167.0 117.0 144.0 148.0 115.0 173.0 123.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.67 (1.6%) stddev-sans-first:2.83 05:56:47 INFO - PID 4199 | Values: 163.0 163.0 162.0 161.0 162.0 169.0 162.0 160.0 165.0 166.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#3] audio-fft Cycles:10 Average:83.60 Median:74.00 stddev:25.37 (34.3%) stddev-sans-first:26.62 05:56:47 INFO - PID 4199 | Values: 73.0 76.0 74.0 154.0 77.0 73.0 71.0 73.0 91.0 74.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:81.00 stddev:27.14 (33.5%) stddev-sans-first:28.18 05:56:47 INFO - PID 4199 | Values: 82.0 81.0 132.0 80.0 80.0 82.0 138.0 81.0 81.0 141.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:56:47 INFO - PID 4199 | Values: 113.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 113.0 113.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 05:56:47 INFO - PID 4199 | Values: 146.0 147.0 146.0 147.0 148.0 147.0 147.0 148.0 147.0 149.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:56:47 INFO - PID 4199 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 96.0 94.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#8] json-parse-financial Cycles:10 Average:47.40 Median:48.00 stddev:1.43 (3.0%) stddev-sans-first:1.39 05:56:47 INFO - PID 4199 | Values: 49.0 49.0 49.0 46.0 49.0 47.0 46.0 46.0 47.0 46.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#9] json-stringify-tinderbox Cycles:10 Average:53.10 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 05:56:47 INFO - PID 4199 | Values: 54.0 53.0 52.0 52.0 54.0 54.0 53.0 53.0 53.0 53.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:1.03 (1.4%) stddev-sans-first:0.87 05:56:47 INFO - PID 4199 | Values: 76.0 74.0 74.0 74.0 73.0 74.0 74.0 73.0 74.0 76.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:122.00 stddev:11.35 (9.3%) stddev-sans-first:11.98 05:56:47 INFO - PID 4199 | Values: 122.0 120.0 120.0 122.0 120.0 121.0 127.0 120.0 125.0 157.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:175.00 stddev:3.78 (2.2%) stddev-sans-first:3.77 05:56:47 INFO - PID 4199 | Values: 178.0 177.0 172.0 175.0 170.0 171.0 175.0 182.0 173.0 171.0 05:56:47 INFO - PID 4199 | 05:56:47 INFO - PID 4199 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:60.50 stddev:1.65 (2.7%) stddev-sans-first:1.67 05:56:47 INFO - PID 4199 | Values: 62.0 64.0 61.0 60.0 62.0 60.0 60.0 59.0 59.0 59.0 05:56:47 INFO - PID 4199 | -------- Summary: end -------- 05:56:47 INFO - PID 4199 | 05:56:48 INFO - TEST-INFO | 4199: exit 0 05:56:48 INFO - TEST-OK | kraken | took 59660ms 05:56:48 INFO - SUITE-END | took 1177s 05:56:48 INFO - Completed test suite (00:19:37) 05:56:48 INFO - javascript benchmark 05:56:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8496.931173300132, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.6816852399015, 3412.897613071608, 3418.4872269159623, 3433.605135409429, 3449.6377880322566, 6169.660668663228, 6202.286737025243, 6203.596766210193, 6208.317085120633, 6230.688465576725, 6269.780557680482, 6271.247450305969, 6298.559100862942, 6315.684215789203, 6345.428911397985, 5507.146392309189, 5514.724263786795, 5527.861803454905, 5544.91682624761, 5631.7184140793, 5541.806036788693, 5552.0, 5568.470995255465, 5593.580481463886, 5602.327720673525, 5449.863753406157, 5496.780128794843, 5505.779768809243, 5532.529734972532, 5593.496585307301, 5478.0, 5488.890222195574, 5547.639403438763, 5554.416786237468, 5562.554995600342, 5459.69971651559, 5516.420775818561, 5522.972385138049, 5535.944640553583, 5553.194786755897, 6223.626582405071, 6244.313125556185, 6259.061140828867, 6272.2786879508985, 6274.152989346426, 6622.701978410983, 6747.561408508481, 6778.694958726869, 6787.660616969132, 6800.625965571891, 6706.061151438803, 6786.864262714718, 6860.485463590251, 6876.724931002754, 6891.965540172267, 6283.183186185766, 6285.685715714288, 6295.464885484694, 6331.810045698637, 6350.396712312323, 6661.766838160641, 6812.523123381415, 6984.092068031225, 6986.056882320923, 6994.195667498303, 6551.213854337415, 6567.179102612174, 6587.077809106729, 6599.47204223661, 6682.198136223684, 6776.322367763283, 6863.897041544381, 6865.794026179223, 6869.347411995853, 6892.551984121116, 6829.863402731918, 6832.145981752281, 6833.214180369222, 6838.48711346651, 6850.4862135340045, 6659.500537459709, 6679.131712877392, 6745.460363170934, 6759.763408280686, 6782.457403407716, 5111.386633603991, 5121.795128194905, 5130.410002849645, 5131.999260144236, 5132.307138536325, 4482.596566308983, 4517.34498497716, 4517.412736344254, 4518.728876267434, 4538.931916021263, 6432.774852880127, 6463.385978332051, 6465.967670161619, 6473.22321321435, 6483.740650374027, 6600.636964966877, 6733.158355205599, 6887.965560172167, 6910.861782764317, 6919.861602767916, 6318.8420289492215, 6352.968235158794, 6422.967885160544, 6432.742690292336, 6443.742250310029, 5701.686407247641, 5708.372079071299, 5718.68547229898, 5736.856578585569, 5739.196512488255, 7150.0, 7151.2133665297815, 7155.606441645656, 7157.141143062866, 7195.02867112954, 6666.433353164842, 6853.451723862178, 6860.416864566568, 6862.348076932683, 6863.759768408082, 7047.330503602149, 7105.786826395217, 7146.0, 7153.213146553979, 7193.496455248082, 6676.1988561371, 6735.4274886635185, 6746.123004009643, 6751.426128778912, 6771.221309549464, 6847.315268473312, 6888.827779305357, 6900.482463815334, 6902.344277293649, 6905.413039891666, 6539.378759017885, 6648.601083934979, 6656.201255849329, 6666.733330666719, 6681.09805176295, 6511.609303441809, 6581.80254592363, 6625.238097618835, 6638.17022872141, 6690.063391125149, 6526.412622863965, 6599.406053455212, 6604.207495100619, 6606.405423511907, 6664.0, 6616.503762217949, 6634.767783127568, 6639.170103737033, 6709.228438729413, 6735.6968936397, 6417.96791016042, 6436.549441539048, 6455.677216139268, 6498.967505162444, 6506.154199953976], "value": 6192.723273207658, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.8364902493039, 903.2232280238998, 944.1879983214435, 957.5738796235678, 971.5385192033781, 40859.59140408595, 41681.0, 41886.79056604713, 41952.0, 41960.370594441105, 37394.8130259349, 37721.62278377215, 37735.05662358442, 37860.43209351862, 37891.621083789156, 6739.157605299325, 6753.223379311393, 6773.0, 6816.795496135124, 6823.795286141423, 6673.49948753843, 6673.799786006428, 6759.256481787, 6764.729410823561, 6789.3889549940495, 6716.0933274007875, 6729.7644582439625, 6758.0538724578355, 6760.898586521206, 6789.049533065375, 6734.19189697237, 6748.325167483262, 6754.223264324616, 6785.050092986986, 6797.490188235902, 6216.937830621727, 6247.2815626202655, 6253.1245625612455, 6258.43674069336, 6259.467945224661, 34540.309193815985, 34660.30679386398, 34773.826130869435, 34785.0, 34818.651813481796, 3410.5907291124977, 3431.6225215226304, 3439.1402149462633, 3520.7887526748477, 3598.6941110005682, 30619.693803061906, 30619.69380306213, 30929.0, 31097.68902310993, 31099.0, 3672.7796332219887, 3780.319542482352, 3804.9429258561145, 3807.3717836556934, 3854.402567602026, 191848.0, 194770.0, 195376.02311988492, 200962.0, 202070.0, 47910.520894791305, 48525.27212091821, 48791.0, 48968.0, 49299.27452539144, 50623.493765062616, 50886.491135088916, 51011.23483147756, 51117.48882511127, 51302.230466543035, 15424.922875385551, 15449.768253476206, 15598.142102184489, 15632.3747050119, 15697.372105115895, 12857.935710321575, 12868.613941581767, 12870.841624253862, 12876.291803950873, 12896.80654790179, 13613.387397567134, 13703.794443083361, 13714.657133571542, 13809.930950345184, 13950.581482555337, 5557.722113894289, 5599.80400685974, 5641.971790141023, 5704.80033198836, 5795.913061304083, 1066.6373433032807, 1091.247039542713, 1104.6023431564631, 1112.265904503024, 1118.8769235384102, 24021.51956960851, 24676.629850552257, 25310.0, 25395.61906571403, 25595.48809023809, 1207.5954555224098, 1214.9817752733716, 1218.1594699657207, 1219.951201951912, 1230.1450491908217, 13396.0, 13425.932870335586, 13438.849784034703, 13514.459421623025, 13645.0, 268772.0, 269388.0, 269510.0, 269794.0, 270573.0, 51320.74339628278, 51787.74106129521, 51922.740386297824, 51999.74000129975, 52222.47777522176, 1447.1027962663215, 1525.3212320517264, 1526.381815364779, 1528.7859699642058, 1542.5603702944832, 24104.0, 29844.70155298506, 30571.0, 30617.846910765304, 30941.381172376878, 50909.23636145387, 50968.49031509637, 51317.0, 51400.74299628478, 51424.48575514197, 244927.0, 245760.0, 246820.0, 246997.0, 248401.0, 31569.684303156675, 32241.51637725483, 32264.83867580647, 35494.46758298576, 35582.28835423225, 39517.80241098776, 41505.58494415017, 42032.1593568133, 42594.148117036864, 44011.33982990322, 30133.09600711982, 30550.388992219585, 30801.537976929914, 31812.8409357961, 32504.187395315308, 30682.84658576693, 31149.0, 31717.524237136, 31823.681763182998, 32365.35269294648, 36522.817385913964, 36723.08192295214, 37658.43512347372, 37806.43290350702, 38129.04677383087, 31590.684093159693, 32429.837850810596, 32756.672433275362, 32766.344673105927, 33526.83236583802, 25100.62349064802, 26663.600045999712, 27039.86480067587, 27066.729332707208, 27435.725642743317], "value": 17236.582834464425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8339639806256, 568.897598432282, 570.1020892094951, 583.3408248678993, 591.7366771786554, 21995.670064949038, 22739.54520909581, 22827.657585136236, 22887.542249155005, 22903.0, 24487.75512244877, 26019.349516262104, 27260.72739272607, 27304.180874573743, 27487.587686184725, 6229.875402491947, 6289.968550157243, 6337.397947195032, 6337.461315788163, 6338.904916426257, 6234.314225435199, 6294.0, 6300.0, 6320.715567799437, 6340.461060809814, 5777.566682498808, 6093.451589356957, 6099.756009759604, 6280.183576135096, 6299.496040316787, 6080.726367313481, 6139.815805525842, 6168.87662246757, 6170.81487555374, 6177.7837775677635, 5762.769489220468, 5763.942360576382, 5768.913466298009, 5769.740361683735, 5779.682117483537, 27988.0, 29241.85379073091, 29421.11736647904, 29428.411431771245, 29481.852590737122, 2252.8986195621073, 2332.661764044221, 2349.283468542094, 2353.188150088217, 2355.0815182079004, 18444.262229510936, 18984.5253868653, 19080.0, 19208.903955480273, 19246.230150793952, 2296.666983287414, 2344.1561038026466, 2384.1536254629705, 2385.403649087728, 2395.5089206712582, 129691.0, 131715.0, 131986.0, 132040.33979830134, 132117.0, 14401.0, 15192.164430956182, 15403.537893863202, 15454.768178477332, 15604.0, 23082.192123275603, 23237.53524929492, 23345.299641010795, 23368.64947025796, 23473.647895281585, 10063.792344918656, 10200.132988695896, 10291.742706432398, 10293.125084367763, 10388.11701005423, 9303.302252331103, 9441.15029647335, 9465.242780577537, 9474.810503790024, 9493.19307858826, 9403.200727938201, 9428.481433521221, 9586.555428365722, 9754.414735115774, 9810.16613587853, 2733.248356701883, 2740.5478096113916, 2795.3011747063233, 2843.3886714356513, 3004.2339203502966, 1053.6048981631889, 1055.6516349604613, 1080.2654195147375, 1085.8968398002178, 1095.742500512379, 20426.69359959602, 23924.52150957006, 25854.0, 26241.475170496866, 26524.867375662998, 1111.1222134513644, 1129.9830502542468, 1136.1478890831877, 1139.9886001140048, 1142.5087212498706, 12067.215630983957, 12213.45039473226, 12278.447469863877, 12281.93859030699, 12300.938495307646, 585174.0, 609688.0, 614756.0, 626249.0, 653029.0, 117200.41399793117, 119508.4024579889, 120695.0, 122826.0, 123967.0, 1272.1603741530546, 1314.0473156961127, 1326.8673132686654, 1335.6126723250343, 1337.0840973932886, 17823.197956092266, 19111.13999870037, 19112.61774764469, 19119.0, 19407.8059219406, 53310.0, 54416.0, 54725.72637136789, 55403.72298138483, 55967.16049259183, 69320.6533967327, 69543.3045669557, 69875.30124698688, 71470.0, 71557.64221178861, 11810.645680629596, 12432.254064756144, 12498.312592807482, 12515.374231288217, 12624.0, 18471.722924155878, 18809.0, 18867.15097820629, 19686.212551497778, 19813.10841012129, 15604.375824966874, 16054.598635034217, 16126.758098628765, 16305.510834674978, 16548.834511654728, 13961.371738271599, 14595.416183352972, 14874.851251487347, 14998.625034374229, 15136.318865651292, 16720.665586687956, 16743.24655390486, 16757.32970681159, 16764.74852877232, 16778.0, 12526.311052892179, 13105.475780968654, 13170.407331669907, 13235.933820330836, 13304.201747894771, 15563.610909727347, 15666.843331566994, 15828.0, 15879.603009924844, 16373.42693005739], "value": 11926.151128446638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.8978771485997, 1521.7869498270238, 1522.8477152284772, 1547.9767803482944, 1554.992225038875, 14703.70592588149, 15247.161406122672, 15252.237388130605, 15278.0, 15335.38658453662, 14567.271636418163, 15548.611284717888, 15624.140672263049, 15643.296051677673, 15665.0, 2723.6050772637955, 2742.520058989679, 2750.6286651302116, 2762.3646561290816, 2767.0730305347633, 2588.5211235921415, 2670.572708366652, 2670.9599356009676, 2674.1175412113957, 2688.9596656050176, 2547.2867597072755, 2559.436923876744, 2563.794896408292, 2606.817522773407, 2613.7647611714942, 2650.3109191610224, 2761.4615150045647, 2761.4753196892625, 2774.6254255675426, 2777.847218402987, 2556.3864672478658, 2576.0854896511655, 2587.2496975876975, 2601.375669839244, 2614.73852614737, 14494.42022319106, 14774.778378324334, 14790.334434950346, 14848.2575871206, 14888.702225955529, 8154.836903261961, 8398.03422606402, 8400.915990840074, 8433.241008309282, 8443.788905277417, 4724.952750472486, 4751.9143522408185, 4827.493113223131, 4879.536444037811, 4895.6083513318845, 1625.8049034115863, 1632.648980469193, 1644.4162322375623, 1664.8751343649153, 1670.5573023148754, 23974.760252397427, 24024.879875600684, 24038.87980560086, 24071.277861664177, 24148.39629009271, 6843.657817109125, 6855.348741869514, 6910.101686780687, 6957.408620267232, 7034.2262351141335, 16724.331026758795, 16863.409780657617, 16906.915465422593, 17014.404495842587, 17082.23129959155, 8065.153158918229, 8182.059063207688, 8222.054463736747, 8239.794005149919, 8241.969753780777, 7542.47202695817, 7554.093508778872, 7634.198409166957, 7668.079830420385, 7779.222077792176, 5269.0, 5383.380911195262, 5432.511074003359, 5432.891342173213, 5677.034904066319, 1580.2888700085007, 1598.3686443854613, 1599.7920270364777, 1614.5398561410177, 1619.40082169598, 923.1138107416821, 927.0960813207204, 938.9906100938903, 971.2715463402449, 977.9853302200472, 7695.345895598937, 7799.986001819727, 7820.569868657279, 7980.241877021674, 8018.238267364591, 726.1721637333444, 743.2530307041388, 750.8474491655282, 764.9388048956071, 772.4785769605494, 4926.433460152129, 5200.067701436722, 5277.419483856773, 5406.91889621656, 5600.52395546375, 19637.901810490857, 20381.286654967003, 20404.18383264653, 20529.589408211752, 20543.28098516545, 19888.204471821253, 20102.296419625243, 20813.791862081187, 20884.582308354053, 20896.47758806042, 11255.718607034889, 11376.488058037243, 11385.715357115972, 11399.259048161843, 11515.539378424937, 7890.210978902293, 8353.289970352587, 8578.957105214435, 8688.565571721263, 8711.21599056088, 17231.310747569958, 17387.652246954738, 17943.0, 18135.0, 18177.636447271245, 17662.293508260038, 18661.253549857855, 18663.813361866207, 18841.90579047096, 19019.0, 11123.833142502706, 11320.0, 11341.752407235033, 11359.0, 11366.829497557377, 13630.1140425872, 13732.519361822287, 13756.0, 13784.448622055406, 13831.30843457803, 10680.145588353069, 10689.465526723478, 11086.889131108586, 11135.0, 11566.074714023027, 10616.84074738895, 10756.193285503776, 10922.0, 10933.671989840317, 11004.779904402027, 9974.850377244202, 10147.391156530632, 10152.644657436955, 10155.593776248867, 10159.949200253952, 7111.43108551325, 7153.964230179024, 7251.274872512707, 7266.237045110187, 7428.702851885864, 6649.800505984828, 6849.965750171217, 6932.549384290005, 6990.0, 7012.263712310134], "value": 6565.0301983627905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.87049302427874, 518.548862489634, 521.6817741177882, 532.4489153725895, 538.8733647592815, 6109.908351374727, 6177.0, 6216.07301736462, 6230.750769969196, 6263.091851681509, 6108.205933228674, 6136.294326152494, 6155.276522573676, 6157.7536898524, 6172.475339596129, 4905.092557876796, 4916.483769204236, 4927.531884470987, 4936.80252789888, 4954.1330267203275, 4946.134426475371, 4949.257611358289, 4953.678010929296, 4957.851264462054, 4967.950320496785, 4925.26121081837, 4943.505649435064, 4947.752612369385, 4951.678140920847, 4958.479359667237, 4938.82691615688, 4941.382327209099, 4944.456109827898, 4950.3069570260195, 4963.875903102416, 4185.455890734185, 4345.304751239818, 4358.237308471005, 4579.542045795427, 4580.290055041474, 6001.5198784097165, 6007.128966299862, 6027.668478233695, 6031.306399764039, 6040.5469589780505, 5725.797582507678, 5752.942470575283, 5762.827115186551, 5766.826995190109, 5787.33445653751, 6552.0, 6562.901556476657, 6594.571352862049, 6599.030436303682, 6647.268800431949, 4894.36373271476, 4901.65688401812, 4906.239532872411, 4918.680285781448, 4936.80252789888, 6662.800115996528, 6819.215790184093, 6847.726090956356, 6881.690323935435, 6912.965435172792, 4864.513548645178, 4967.552920237196, 5004.649674522821, 5054.241863720398, 5081.415637201695, 5134.435212126663, 5135.35808023997, 5147.176451767699, 5155.278261043457, 5164.48355164488, 5638.802641907513, 5667.886642267132, 5674.865026994535, 5703.230063941398, 5723.599348045597, 6551.213854337415, 6568.868622627616, 6576.408123268929, 6581.2760596334365, 6613.933860661428, 1773.2906837265198, 1800.297883825309, 1800.324878170686, 1805.386168702621, 1806.5935164588125, 1183.7691650128315, 1249.5938819883575, 1261.6215135459327, 1274.120856608937, 1280.9743805124033, 6162.812201668433, 6227.377262273827, 6264.373562643699, 6285.874282514415, 6290.056491526308, 6639.966800166065, 6733.225679046972, 6736.225334086643, 6748.190217173872, 6769.796906092825, 6120.908186377208, 6166.660833654102, 6174.5060395168275, 6193.535484838655, 6312.621242725451, 3582.2656355447593, 3582.3014512169875, 3585.7629117954266, 3595.7482976191413, 3605.0, 7027.5080744348425, 7028.92971070293, 7037.577745335297, 7067.646617669096, 7085.14978202619, 6928.653567321614, 6945.513814032969, 6949.166100067923, 6978.581285122909, 6996.230414654384, 6474.579152355176, 6960.804883653553, 7020.824479387954, 7066.470014748915, 7088.681009354591, 6654.068430419648, 6670.299618540177, 6696.296888826798, 6715.932840671726, 6751.189857217166, 6570.0, 6675.499337549801, 6702.932970670426, 6706.631135287606, 6709.8257804884925, 7007.194172670208, 7049.0, 7063.187733410724, 7078.929210707827, 7082.433405327664, 5024.120778863758, 5040.243963405372, 5054.963732434916, 5083.881546059861, 5092.159793634009, 6524.575902566318, 6642.070110184674, 6685.498587605852, 6740.797776066725, 6770.763023294358, 6258.217722784652, 6536.901946470902, 6545.574537655038, 6591.637459939558, 6606.702698378681, 6532.738690452328, 6557.344265573595, 6558.376954189344, 6576.868462630816, 6591.571547849375, 6519.282878883414, 6523.347665233438, 6530.47756179495, 6542.803715888341, 6574.737010519526, 6544.738210471528, 6594.505412094208, 6600.306967768315, 6606.4384527315715, 6621.900671489835, 6393.1688880445245, 6403.391677790602, 6423.29343772194, 6442.09810626522, 6455.548111632141], "value": 5122.6219351745785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.7100256915214, 899.5367385796312, 915.0483497162951, 915.199200699388, 919.2829592917525, 17703.911480442595, 17946.012969286683, 18084.734068615202, 18110.909445452788, 18128.4561463156, 17263.30946762128, 17264.0, 17277.913610431962, 17734.645307093884, 19356.903215483904, 1073.1468482556386, 1084.7559299157706, 1086.3156211586688, 1087.836824476331, 1091.8908109189097, 1066.1524088349781, 1075.2741899218036, 1075.6074032977947, 1080.4543705428748, 1080.6541906589894, 1139.128566646516, 1139.800534906388, 1143.1883362812414, 1144.3934714601276, 1145.7880292145937, 1066.1311031509294, 1105.6296140792845, 1138.231693606812, 1144.342003348074, 1148.8104462763633, 808.4098608016122, 808.6846130009242, 810.4488947515687, 811.4806523824698, 815.9510429374197, 17230.827691723047, 17297.740533892003, 17390.913045434692, 17427.39004134849, 17448.38930637434, 17182.398616048504, 18144.09279536031, 18192.818071819245, 18236.0, 18281.360152394736, 12803.295818729966, 12945.0, 13158.671033224246, 13270.402831872589, 13310.334483275894, 3519.9120021999397, 3533.222691007974, 3542.256126213498, 3560.946585801215, 3564.803935783531, 112063.43968280106, 114351.42824285908, 115336.0, 116682.0, 117595.82404175935, 13852.584422467342, 13994.440222391195, 14406.279686015658, 14614.34235459407, 14681.77977330341, 29344.972925947488, 29551.113466596038, 29621.407571848442, 29893.850530747208, 30002.24994375158, 8230.176982301722, 8457.619407126695, 8485.40602157843, 8507.149285071568, 8552.358573107042, 3985.8604948827233, 4032.6169013943627, 4058.3912413137673, 4060.045889216032, 4072.511298644182, 4782.163121453732, 5093.898122037613, 5142.485751424828, 5195.558377537876, 5303.443138470482, 1014.3710899242517, 1040.9115225205792, 1052.85786418834, 1062.1396668698378, 1071.0360675392053, 718.60476737794, 734.1923883727964, 737.2664199121801, 752.7779305105007, 759.8822182561712, 12161.513539458323, 12390.81413778794, 12531.686707832196, 12730.9363453184, 13080.803787943189, 731.7950973727259, 732.571445704269, 736.977890663281, 741.2550386861278, 752.1575835064654, 5758.74085666146, 5789.797357092481, 5885.882282354414, 5957.731902064417, 6027.7287522061615, 111216.0, 112169.0, 112657.4367128159, 113734.0, 116678.41660791641, 100808.0, 102457.0, 104923.4753826226, 107100.464497677, 107225.46387268169, 86800.0, 90004.0, 90220.0, 92737.0, 93740.0, 11338.14963877696, 11934.403279836148, 12003.939980300043, 12095.39523023863, 12309.199902006341, 42808.57191428046, 44113.0, 44740.0, 45971.3104303429, 47101.0, 54074.0, 55216.21450889563, 55362.44637553573, 56032.71983640056, 56557.71721141368, 15600.453984110502, 15902.284397202386, 16262.0, 16297.0, 16493.09287989172, 16022.919885400499, 17037.14814259307, 17182.570435739206, 17200.31198752086, 17310.394136205174, 16643.583910402336, 16754.329826806792, 16757.1621418931, 16891.0, 16926.746098808773, 14092.718145637235, 14418.567442976728, 14435.2060636666, 14505.637359066108, 14770.039947403384, 14730.926345368205, 14900.403983840524, 15418.614534636723, 15808.841911580737, 15931.442399515961, 12128.75742485163, 12132.575359862363, 12212.816807747713, 12335.75328493443, 13060.0, 12693.682657933256, 12775.744485110059, 12886.548970785978, 12887.226766394046, 13173.60479185626], "value": 8789.921817363633, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1480.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 108.0, 105.0, 106.0, 108.0, 108.0, 109.0, 106.0, 108.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 151.0, 167.0, 117.0, 144.0, 148.0, 115.0, 173.0, 123.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 162.0, 169.0, 162.0, 160.0, 165.0, 166.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 154.0, 77.0, 73.0, 71.0, 73.0, 91.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 132.0, 80.0, 80.0, 82.0, 138.0, 81.0, 81.0, 141.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 149.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 96.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 46.0, 49.0, 47.0, 46.0, 46.0, 47.0, 46.0], "value": 47.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 54.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 74.0, 73.0, 74.0, 74.0, 73.0, 74.0, 76.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 120.0, 120.0, 122.0, 120.0, 121.0, 127.0, 120.0, 125.0, 157.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 177.0, 172.0, 175.0, 170.0, 171.0, 175.0, 182.0, 173.0, 171.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 61.0, 60.0, 62.0, 60.0, 60.0, 59.0, 59.0, 59.0], "value": 60.6, "unit": "score"}]}]} 05:56:48 INFO - Return code: 0 05:56:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:56:48 INFO - # TBPL SUCCESS # 05:56:48 INFO - Running post-action listener: _resource_record_post_action 05:56:48 INFO - [mozharness: 2017-06-26 12:56:48.341552Z] Finished run-tests step (success) 05:56:48 INFO - Running post-run listener: _resource_record_post_run 05:56:48 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 5865472; Write bytes: 429953024; Read time: 2292; Write time: 376024 05:56:48 INFO - TinderboxPrint: CPU usage
13.0% 05:56:48 INFO - TinderboxPrint: I/O read bytes / time
5,865,472 / 2,292 05:56:48 INFO - TinderboxPrint: I/O write bytes / time
429,953,024 / 376,024 05:56:48 INFO - TinderboxPrint: CPU idle
8,287.1 (86.9%) 05:56:48 INFO - TinderboxPrint: CPU user
1,194.9 (12.5%) 05:56:48 INFO - TinderboxPrint: Swap in / out
0 / 0 05:56:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 117456896; Read time: 0; Write time: 130848 05:56:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:56:48 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3362816; Write bytes: 299393024; Read time: 1376; Write time: 243884 05:56:48 INFO - Running post-run listener: _upload_blobber_files 05:56:48 INFO - Blob upload gear active. 05:56:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:48 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 05:56:48 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'] 05:56:48 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 05:56:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:56:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:50 INFO - (blobuploader) - INFO - Done attempting. 05:56:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:51 INFO - (blobuploader) - INFO - Done attempting. 05:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:51 INFO - (blobuploader) - INFO - Done attempting. 05:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:55 INFO - (blobuploader) - INFO - Done attempting. 05:56:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:55 INFO - Return code: 0 05:56:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64db97a177934dae616e7cb36b8a69ea7edd7040b0c672558d241860d9ebc1de3dc8acc2581c21f5ab1e1f9d2ef416a4e626bd112d7daee097afdf32c82c37be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53ef503669d5b1e6f10a0c5f8b374dfa99be5243ab3b47c689914a3c89926157cb6221bb8495b92c564984fcc627993a1cf3798fd1129d6d1e1fce2eaa4ccb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72e80cffb03264951115deaf201ba5de1ceab72b7c159955ed3c8974913c1b4241a582286943e19f4cb2be9fe2092b2353a442df46220cd25228a334ad13f895", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68ee40e02cb1c14c9ad36230469461f4f78a35f92da976356ad638d6c3a87f656a0bcda23d32bf8d166894c53b8b43bbc4a627574f8db37ca0cf5ec5befd4513"} 05:56:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:55 INFO - Contents: 05:56:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64db97a177934dae616e7cb36b8a69ea7edd7040b0c672558d241860d9ebc1de3dc8acc2581c21f5ab1e1f9d2ef416a4e626bd112d7daee097afdf32c82c37be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53ef503669d5b1e6f10a0c5f8b374dfa99be5243ab3b47c689914a3c89926157cb6221bb8495b92c564984fcc627993a1cf3798fd1129d6d1e1fce2eaa4ccb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72e80cffb03264951115deaf201ba5de1ceab72b7c159955ed3c8974913c1b4241a582286943e19f4cb2be9fe2092b2353a442df46220cd25228a334ad13f895", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68ee40e02cb1c14c9ad36230469461f4f78a35f92da976356ad638d6c3a87f656a0bcda23d32bf8d166894c53b8b43bbc4a627574f8db37ca0cf5ec5befd4513"} 05:56:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:55 INFO - Copying logs to upload dir... 05:56:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.530503 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-06-26 05:56:55.784797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-26 05:56:55.788860) ========= 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=00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513 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/64db97a177934dae616e7cb36b8a69ea7edd7040b0c672558d241860d9ebc1de3dc8acc2581c21f5ab1e1f9d2ef416a4e626bd112d7daee097afdf32c82c37be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53ef503669d5b1e6f10a0c5f8b374dfa99be5243ab3b47c689914a3c89926157cb6221bb8495b92c564984fcc627993a1cf3798fd1129d6d1e1fce2eaa4ccb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72e80cffb03264951115deaf201ba5de1ceab72b7c159955ed3c8974913c1b4241a582286943e19f4cb2be9fe2092b2353a442df46220cd25228a334ad13f895", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68ee40e02cb1c14c9ad36230469461f4f78a35f92da976356ad638d6c3a87f656a0bcda23d32bf8d166894c53b8b43bbc4a627574f8db37ca0cf5ec5befd4513"} build_url:https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/cej7SkrjSWuOBfebG5uVaw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/64db97a177934dae616e7cb36b8a69ea7edd7040b0c672558d241860d9ebc1de3dc8acc2581c21f5ab1e1f9d2ef416a4e626bd112d7daee097afdf32c82c37be", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e53ef503669d5b1e6f10a0c5f8b374dfa99be5243ab3b47c689914a3c89926157cb6221bb8495b92c564984fcc627993a1cf3798fd1129d6d1e1fce2eaa4ccb9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72e80cffb03264951115deaf201ba5de1ceab72b7c159955ed3c8974913c1b4241a582286943e19f4cb2be9fe2092b2353a442df46220cd25228a334ad13f895", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68ee40e02cb1c14c9ad36230469461f4f78a35f92da976356ad638d6c3a87f656a0bcda23d32bf8d166894c53b8b43bbc4a627574f8db37ca0cf5ec5befd4513"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-26 05:56:55.815680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:56:55.816007) ========= 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=00204705a9daa57ed339a427000001b9-1498479788.473562-1883243513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-26 05:56:55.898215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-26 05:56:55.901570) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-26 05:56:55.901877) ========= ========= Total master_lag: 0.20 =========